builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-034 starttime: 1484758461.24 results: success (0) buildid: 20170118070027 builduid: 436fa47a262a452092f35e89ab1634db revision: 27643a39e551670484fe7dd5836aaa01d66b9a7b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.244423) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.244925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.245206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.262174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.262529) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-18 08:54:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-01-18 08:54:22 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116753 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.393626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.393950) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017024 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.443368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:21.444033) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 27643a39e551670484fe7dd5836aaa01d66b9a7b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 27643a39e551670484fe7dd5836aaa01d66b9a7b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-18 08:54:22,124 truncating revision to first 12 chars 2017-01-18 08:54:22,124 Setting DEBUG logging. 2017-01-18 08:54:22,124 attempt 1/10 2017-01-18 08:54:22,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/27643a39e551?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 08:54:22,442 unpacking tar archive at: mozilla-aurora-27643a39e551/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611842 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:22.068946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:22.069269) ========= script_repo_revision: 27643a39e551670484fe7dd5836aaa01d66b9a7b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:22.069684) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:22.069949) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:54:22.078804) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 08:54:22.079072) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:22 INFO - MultiFileLogger online at 20170118 08:54:22 in /builds/slave/test 08:54:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:54:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:22 INFO - {'append_to_log': False, 08:54:22 INFO - 'base_work_dir': '/builds/slave/test', 08:54:22 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:54:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:22 INFO - 'branch': 'Mozilla-Aurora', 08:54:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:22 INFO - 'config_files': ('talos/linux_config.py',), 08:54:22 INFO - 'default_actions': ('clobber', 08:54:22 INFO - 'read-buildbot-config', 08:54:22 INFO - 'download-and-extract', 08:54:22 INFO - 'populate-webroot', 08:54:22 INFO - 'create-virtualenv', 08:54:22 INFO - 'install', 08:54:22 INFO - 'run-tests'), 08:54:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:22 INFO - 'download_minidump_stackwalk': True, 08:54:22 INFO - 'download_symbols': 'ondemand', 08:54:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:22 INFO - 'installer_path': 'installer.exe', 08:54:22 INFO - 'log_level': 'info', 08:54:22 INFO - 'log_name': 'talos', 08:54:22 INFO - 'log_to_console': True, 08:54:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:22 INFO - 'opt_config_files': (), 08:54:22 INFO - 'pip_index': False, 08:54:22 INFO - 'sps_profile': False, 08:54:22 INFO - 'sps_profile_interval': 0, 08:54:22 INFO - 'suite': 'dromaeojs', 08:54:22 INFO - 'system_bits': '32', 08:54:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:22 INFO - 'title': 'talos-linux64-ix-034', 08:54:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:22 INFO - 'use_talos_json': True, 08:54:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:22 INFO - 'work_dir': 'build'} 08:54:22 INFO - [mozharness: 2017-01-18 16:54:22.859295Z] Running clobber step. 08:54:22 INFO - Running pre-action listener: _resource_record_pre_action 08:54:22 INFO - Running main action method: clobber 08:54:22 INFO - rmtree: /builds/slave/test/build 08:54:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - [mozharness: 2017-01-18 16:54:23.940081Z] Finished clobber step (success) 08:54:23 INFO - [mozharness: 2017-01-18 16:54:23.940179Z] Running read-buildbot-config step. 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: read_buildbot_config 08:54:23 INFO - Using buildbot properties: 08:54:23 INFO - { 08:54:23 INFO - "project": "", 08:54:23 INFO - "product": "firefox", 08:54:23 INFO - "script_repo_revision": "production", 08:54:23 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:54:23 INFO - "repository": "", 08:54:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:54:23 INFO - "buildid": "20170118070027", 08:54:23 INFO - "pgo_build": "True", 08:54:23 INFO - "basedir": "/builds/slave/test", 08:54:23 INFO - "buildnumber": 713, 08:54:23 INFO - "slavename": "talos-linux64-ix-034", 08:54:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:54:23 INFO - "platform": "ubuntu64_hw", 08:54:23 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:54:23 INFO - "branch": "mozilla-aurora", 08:54:23 INFO - "repo_path": "releases/mozilla-aurora", 08:54:23 INFO - "revision": "27643a39e551670484fe7dd5836aaa01d66b9a7b", 08:54:23 INFO - "stage_platform": "linux64-pgo", 08:54:23 INFO - "builduid": "436fa47a262a452092f35e89ab1634db", 08:54:23 INFO - "slavebuilddir": "test" 08:54:23 INFO - } 08:54:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - [mozharness: 2017-01-18 16:54:23.942605Z] Finished read-buildbot-config step (success) 08:54:23 INFO - [mozharness: 2017-01-18 16:54:23.942693Z] Running download-and-extract step. 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: download_and_extract 08:54:23 INFO - mkdir: /builds/slave/test/build/tests 08:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:23 INFO - trying https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:54:23 INFO - Downloading https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:54:24 INFO - Downloaded 1361 bytes. 08:54:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:54:24 INFO - Using the following test package requirements: 08:54:24 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:54:24 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:54:24 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:54:24 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'jsshell-linux-x86_64.zip'], 08:54:24 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:54:24 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:54:24 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:54:24 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:54:24 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:54:24 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:54:24 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:54:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:54:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:54:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:54:24 INFO - Fetch https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:54:25 INFO - Http code: 200 08:54:25 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:54:25 INFO - x-amz-cf-id: 33LrMm4ZoKNBQcwIS5uTncdqxZpxK4E-W3ck9hmS6AIi4hGVVd1Qwg== 08:54:25 INFO - x-amz-version-id: OY_lAd7h6UVf8G2lFvSIRPkG3G.mCjRd 08:54:25 INFO - Expected file size: 21949551 08:54:25 INFO - Obtained file size: 21949551 08:54:29 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:54:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:54:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:54:29 INFO - Fetch https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:54:29 INFO - Http code: 200 08:54:29 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:54:29 INFO - x-amz-cf-id: UMs2wKVUP4tkieME1PDteomrJ41w-eei_lgEHgrUBxHXuI1meiF9jA== 08:54:29 INFO - x-amz-version-id: OY_lAd7h6UVf8G2lFvSIRPkG3G.mCjRd 08:54:30 INFO - Expected file size: 21949551 08:54:30 INFO - Obtained file size: 21949551 08:54:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:54:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:54:34 INFO - Fetch https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:54:35 INFO - Http code: 200 08:54:35 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:54:35 INFO - x-amz-cf-id: 4OERZbAjSMLuElVmSym5H22LEK9nz8rL_vLH1jzlhFmCv53N3NLhtQ== 08:54:35 INFO - x-amz-version-id: 1jTm6JIEn.UmEaIym8aPbHv.YKPyRpzZ 08:54:35 INFO - Expected file size: 14409038 08:54:35 INFO - Obtained file size: 14409038 08:54:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:35 INFO - trying https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:54:35 INFO - Downloading https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:54:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:54:36 INFO - Downloaded 64157928 bytes. 08:54:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:54:36 INFO - mkdir: /builds/slave/test/properties 08:54:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:36 INFO - Contents: 08:54:36 INFO - build_url:https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:54:37 INFO - Running post-action listener: _resource_record_post_action 08:54:37 INFO - Running post-action listener: set_extra_try_arguments 08:54:37 INFO - [mozharness: 2017-01-18 16:54:37.277970Z] Finished download-and-extract step (success) 08:54:37 INFO - [mozharness: 2017-01-18 16:54:37.278195Z] Running populate-webroot step. 08:54:37 INFO - Running pre-action listener: _resource_record_pre_action 08:54:37 INFO - Running main action method: populate_webroot 08:54:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:37 INFO - '--tppagecycles', 08:54:37 INFO - '7'], 08:54:37 INFO - 'tests': ['tsvgm']}}, 08:54:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['damp', 'tps']}, 08:54:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['damp', 'tps']}, 08:54:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['dromaeo_dom']}, 08:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['basic_compositor_video']}, 08:54:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore', 08:54:37 INFO - 'tabpaint']}, 08:54:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['tsvgx', 08:54:37 INFO - 'tsvgr_opacity', 08:54:37 INFO - 'tart', 08:54:37 INFO - 'tscrollx', 08:54:37 INFO - 'cart']}, 08:54:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:37 INFO - 'tsvgr_opacity', 08:54:37 INFO - 'tart', 08:54:37 INFO - 'tscrollx', 08:54:37 INFO - 'cart']}, 08:54:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--disable-e10s'], 08:54:37 INFO - 'tests': ['tp5o']}, 08:54:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['tp5o']}, 08:54:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--disable-e10s', 08:54:37 INFO - '--xperf_path', 08:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:37 INFO - 'tests': ['tp5n']}, 08:54:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--xperf_path', 08:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:37 INFO - 'tests': ['tp5n']}}, 08:54:37 INFO - 'talos.zip': {'path': '', 08:54:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:37 INFO - Running post-action listener: _resource_record_post_action 08:54:37 INFO - [mozharness: 2017-01-18 16:54:37.299506Z] Finished populate-webroot step (success) 08:54:37 INFO - [mozharness: 2017-01-18 16:54:37.299594Z] Running create-virtualenv step. 08:54:37 INFO - Running pre-action listener: _resource_record_pre_action 08:54:37 INFO - Running main action method: create_virtualenv 08:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:54:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:37 INFO - Using real prefix '/usr' 08:54:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:39 INFO - Installing pip.................done. 08:54:39 INFO - Return code: 0 08:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:40 INFO - Reading from file tmpfile_stdout 08:54:40 INFO - Output received: 08:54:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:54:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:54:40 INFO - Using env: {'DISPLAY': ':0', 08:54:40 INFO - 'HOME': '/home/cltbld', 08:54:40 INFO - 'LANG': 'en_US.UTF-8', 08:54:40 INFO - 'LANGUAGE': 'en_US:en', 08:54:40 INFO - 'LOGNAME': 'cltbld', 08:54:40 INFO - 'MAIL': '/var/mail/cltbld', 08:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:40 INFO - 'MOZ_NO_REMOTE': '1', 08:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:40 INFO - 'NO_EM_RESTART': '1', 08:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:40 INFO - 'PWD': '/builds/slave/test', 08:54:40 INFO - 'SHELL': '/bin/bash', 08:54:40 INFO - 'SHLVL': '1', 08:54:40 INFO - 'TERM': 'linux', 08:54:40 INFO - 'TMOUT': '86400', 08:54:40 INFO - 'USER': 'cltbld', 08:54:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:40 INFO - '_': '/tools/buildbot/bin/python'} 08:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:54:40 INFO - Cleaning up... 08:54:40 INFO - Return code: 0 08:54:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:54:40 INFO - Using env: {'DISPLAY': ':0', 08:54:40 INFO - 'HOME': '/home/cltbld', 08:54:40 INFO - 'LANG': 'en_US.UTF-8', 08:54:40 INFO - 'LANGUAGE': 'en_US:en', 08:54:40 INFO - 'LOGNAME': 'cltbld', 08:54:40 INFO - 'MAIL': '/var/mail/cltbld', 08:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:40 INFO - 'MOZ_NO_REMOTE': '1', 08:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:40 INFO - 'NO_EM_RESTART': '1', 08:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:40 INFO - 'PWD': '/builds/slave/test', 08:54:40 INFO - 'SHELL': '/bin/bash', 08:54:40 INFO - 'SHLVL': '1', 08:54:40 INFO - 'TERM': 'linux', 08:54:40 INFO - 'TMOUT': '86400', 08:54:40 INFO - 'USER': 'cltbld', 08:54:40 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:40 INFO - '_': '/tools/buildbot/bin/python'} 08:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:40 INFO - Downloading/unpacking psutil>=3.1.1 08:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:42 INFO - Installing collected packages: psutil 08:54:42 INFO - Running setup.py install for psutil 08:54:42 INFO - building 'psutil._psutil_linux' extension 08:54:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:54:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:54:42 INFO - building 'psutil._psutil_posix' extension 08:54:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:54:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:54:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:43 INFO - Successfully installed psutil 08:54:43 INFO - Cleaning up... 08:54:43 INFO - Return code: 0 08:54:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:54:43 INFO - Using env: {'DISPLAY': ':0', 08:54:43 INFO - 'HOME': '/home/cltbld', 08:54:43 INFO - 'LANG': 'en_US.UTF-8', 08:54:43 INFO - 'LANGUAGE': 'en_US:en', 08:54:43 INFO - 'LOGNAME': 'cltbld', 08:54:43 INFO - 'MAIL': '/var/mail/cltbld', 08:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:43 INFO - 'MOZ_NO_REMOTE': '1', 08:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:43 INFO - 'NO_EM_RESTART': '1', 08:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:43 INFO - 'PWD': '/builds/slave/test', 08:54:43 INFO - 'SHELL': '/bin/bash', 08:54:43 INFO - 'SHLVL': '1', 08:54:43 INFO - 'TERM': 'linux', 08:54:43 INFO - 'TMOUT': '86400', 08:54:43 INFO - 'USER': 'cltbld', 08:54:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:43 INFO - '_': '/tools/buildbot/bin/python'} 08:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:54:45 INFO - Installing collected packages: mozsystemmonitor 08:54:45 INFO - Running setup.py install for mozsystemmonitor 08:54:45 INFO - Successfully installed mozsystemmonitor 08:54:45 INFO - Cleaning up... 08:54:45 INFO - Return code: 0 08:54:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:54:45 INFO - Using env: {'DISPLAY': ':0', 08:54:45 INFO - 'HOME': '/home/cltbld', 08:54:45 INFO - 'LANG': 'en_US.UTF-8', 08:54:45 INFO - 'LANGUAGE': 'en_US:en', 08:54:45 INFO - 'LOGNAME': 'cltbld', 08:54:45 INFO - 'MAIL': '/var/mail/cltbld', 08:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:45 INFO - 'MOZ_NO_REMOTE': '1', 08:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:45 INFO - 'NO_EM_RESTART': '1', 08:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:45 INFO - 'PWD': '/builds/slave/test', 08:54:45 INFO - 'SHELL': '/bin/bash', 08:54:45 INFO - 'SHLVL': '1', 08:54:45 INFO - 'TERM': 'linux', 08:54:45 INFO - 'TMOUT': '86400', 08:54:45 INFO - 'USER': 'cltbld', 08:54:45 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:45 INFO - '_': '/tools/buildbot/bin/python'} 08:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:45 INFO - Downloading/unpacking jsonschema==2.5.1 08:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:48 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:48 INFO - warning: no files found matching '*.txt' 08:54:48 INFO - no previously-included directories found matching 'build' 08:54:48 INFO - no previously-included directories found matching 'dist' 08:54:48 INFO - no previously-included directories found matching '.git*' 08:54:48 INFO - Installing collected packages: jsonschema, functools32 08:54:48 INFO - Running setup.py install for functools32 08:54:48 INFO - warning: no files found matching '*.txt' 08:54:48 INFO - no previously-included directories found matching 'build' 08:54:48 INFO - no previously-included directories found matching 'dist' 08:54:48 INFO - no previously-included directories found matching '.git*' 08:54:48 INFO - Successfully installed jsonschema functools32 08:54:48 INFO - Cleaning up... 08:54:48 INFO - Return code: 0 08:54:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:54:48 INFO - Using env: {'DISPLAY': ':0', 08:54:48 INFO - 'HOME': '/home/cltbld', 08:54:48 INFO - 'LANG': 'en_US.UTF-8', 08:54:48 INFO - 'LANGUAGE': 'en_US:en', 08:54:48 INFO - 'LOGNAME': 'cltbld', 08:54:48 INFO - 'MAIL': '/var/mail/cltbld', 08:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:48 INFO - 'MOZ_NO_REMOTE': '1', 08:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:48 INFO - 'NO_EM_RESTART': '1', 08:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:48 INFO - 'PWD': '/builds/slave/test', 08:54:48 INFO - 'SHELL': '/bin/bash', 08:54:48 INFO - 'SHLVL': '1', 08:54:48 INFO - 'TERM': 'linux', 08:54:48 INFO - 'TMOUT': '86400', 08:54:48 INFO - 'USER': 'cltbld', 08:54:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:48 INFO - '_': '/tools/buildbot/bin/python'} 08:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:54:48 INFO - Cleaning up... 08:54:48 INFO - Return code: 0 08:54:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:54:48 INFO - Using env: {'DISPLAY': ':0', 08:54:48 INFO - 'HOME': '/home/cltbld', 08:54:48 INFO - 'LANG': 'en_US.UTF-8', 08:54:48 INFO - 'LANGUAGE': 'en_US:en', 08:54:48 INFO - 'LOGNAME': 'cltbld', 08:54:48 INFO - 'MAIL': '/var/mail/cltbld', 08:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:48 INFO - 'MOZ_NO_REMOTE': '1', 08:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:48 INFO - 'NO_EM_RESTART': '1', 08:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:48 INFO - 'PWD': '/builds/slave/test', 08:54:48 INFO - 'SHELL': '/bin/bash', 08:54:48 INFO - 'SHLVL': '1', 08:54:48 INFO - 'TERM': 'linux', 08:54:48 INFO - 'TMOUT': '86400', 08:54:48 INFO - 'USER': 'cltbld', 08:54:48 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:48 INFO - '_': '/tools/buildbot/bin/python'} 08:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:48 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:50 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:51 INFO - Downloading docopt-0.6.1.tar.gz 08:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:51 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:51 INFO - Running setup.py install for blobuploader 08:54:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:51 INFO - Running setup.py install for requests 08:54:52 INFO - Running setup.py install for docopt 08:54:52 INFO - Successfully installed blobuploader requests docopt 08:54:52 INFO - Cleaning up... 08:54:52 INFO - Return code: 0 08:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:52 INFO - Using env: {'DISPLAY': ':0', 08:54:52 INFO - 'HOME': '/home/cltbld', 08:54:52 INFO - 'LANG': 'en_US.UTF-8', 08:54:52 INFO - 'LANGUAGE': 'en_US:en', 08:54:52 INFO - 'LOGNAME': 'cltbld', 08:54:52 INFO - 'MAIL': '/var/mail/cltbld', 08:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:52 INFO - 'MOZ_NO_REMOTE': '1', 08:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:52 INFO - 'NO_EM_RESTART': '1', 08:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:52 INFO - 'PWD': '/builds/slave/test', 08:54:52 INFO - 'SHELL': '/bin/bash', 08:54:52 INFO - 'SHLVL': '1', 08:54:52 INFO - 'TERM': 'linux', 08:54:52 INFO - 'TMOUT': '86400', 08:54:52 INFO - 'USER': 'cltbld', 08:54:52 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:52 INFO - '_': '/tools/buildbot/bin/python'} 08:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:52 INFO - Running setup.py (path:/tmp/pip-ajvAZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:52 INFO - Running setup.py (path:/tmp/pip-Bh_VPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:52 INFO - Running setup.py (path:/tmp/pip-HckiKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:52 INFO - Running setup.py (path:/tmp/pip-3Z8sm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:52 INFO - Running setup.py (path:/tmp/pip-SC55H4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:52 INFO - Running setup.py (path:/tmp/pip-xOaf9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:52 INFO - Running setup.py (path:/tmp/pip-AOOndK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:52 INFO - Running setup.py (path:/tmp/pip-eh3_qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:53 INFO - Running setup.py (path:/tmp/pip-hadrf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:53 INFO - Running setup.py (path:/tmp/pip-NY076h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:53 INFO - Running setup.py (path:/tmp/pip-QDfbwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:53 INFO - Running setup.py (path:/tmp/pip-Cjy_yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:53 INFO - Running setup.py (path:/tmp/pip-VrY3EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:53 INFO - Running setup.py (path:/tmp/pip-WM7CoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:53 INFO - Running setup.py (path:/tmp/pip-eelMpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:53 INFO - Running setup.py (path:/tmp/pip-wvXDqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:53 INFO - Running setup.py (path:/tmp/pip-N9VgKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:53 INFO - Running setup.py install for manifestparser 08:54:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:53 INFO - Running setup.py install for mozcrash 08:54:53 INFO - Running setup.py install for mozdebug 08:54:53 INFO - Running setup.py install for mozdevice 08:54:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for mozfile 08:54:54 INFO - Running setup.py install for mozhttpd 08:54:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for mozinfo 08:54:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for mozInstall 08:54:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for mozleak 08:54:54 INFO - Running setup.py install for mozlog 08:54:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for moznetwork 08:54:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:54 INFO - Running setup.py install for mozprocess 08:54:54 INFO - Running setup.py install for mozprofile 08:54:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:55 INFO - Running setup.py install for mozrunner 08:54:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:55 INFO - Running setup.py install for mozscreenshot 08:54:55 INFO - Running setup.py install for moztest 08:54:55 INFO - Running setup.py install for mozversion 08:54:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:55 INFO - Cleaning up... 08:54:55 INFO - Return code: 0 08:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:55 INFO - Using env: {'DISPLAY': ':0', 08:54:55 INFO - 'HOME': '/home/cltbld', 08:54:55 INFO - 'LANG': 'en_US.UTF-8', 08:54:55 INFO - 'LANGUAGE': 'en_US:en', 08:54:55 INFO - 'LOGNAME': 'cltbld', 08:54:55 INFO - 'MAIL': '/var/mail/cltbld', 08:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:55 INFO - 'MOZ_NO_REMOTE': '1', 08:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:55 INFO - 'NO_EM_RESTART': '1', 08:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:55 INFO - 'PWD': '/builds/slave/test', 08:54:55 INFO - 'SHELL': '/bin/bash', 08:54:55 INFO - 'SHLVL': '1', 08:54:55 INFO - 'TERM': 'linux', 08:54:55 INFO - 'TMOUT': '86400', 08:54:55 INFO - 'USER': 'cltbld', 08:54:55 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:55 INFO - '_': '/tools/buildbot/bin/python'} 08:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:55 INFO - Running setup.py (path:/tmp/pip-6DO4d7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:55 INFO - Running setup.py (path:/tmp/pip-ht17vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:55 INFO - Running setup.py (path:/tmp/pip-U4zHuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:55 INFO - Running setup.py (path:/tmp/pip-WMZZXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:55 INFO - Running setup.py (path:/tmp/pip-zzflFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:56 INFO - Running setup.py (path:/tmp/pip-Q8u7qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:56 INFO - Running setup.py (path:/tmp/pip-xNQAkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:56 INFO - Running setup.py (path:/tmp/pip-RLDdKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:56 INFO - Running setup.py (path:/tmp/pip-8KCrpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:56 INFO - Running setup.py (path:/tmp/pip-PGz5U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:56 INFO - Running setup.py (path:/tmp/pip-juPkqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:56 INFO - Running setup.py (path:/tmp/pip-cSLm3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:56 INFO - Running setup.py (path:/tmp/pip-KVdh1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:56 INFO - Running setup.py (path:/tmp/pip-03q4NR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:56 INFO - Running setup.py (path:/tmp/pip-YaOK7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:56 INFO - Running setup.py (path:/tmp/pip-3wzVbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:56 INFO - Running setup.py (path:/tmp/pip-_9F6Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:54:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:58 INFO - Downloading blessings-1.6.tar.gz 08:54:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:59 INFO - Installing collected packages: blessings 08:54:59 INFO - Running setup.py install for blessings 08:54:59 INFO - Successfully installed blessings 08:54:59 INFO - Cleaning up... 08:54:59 INFO - Return code: 0 08:54:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:59 INFO - Reading from file tmpfile_stdout 08:54:59 INFO - Current package versions: 08:54:59 INFO - argparse == 1.2.1 08:54:59 INFO - blessings == 1.6 08:54:59 INFO - blobuploader == 1.2.4 08:54:59 INFO - docopt == 0.6.1 08:54:59 INFO - functools32 == 3.2.3-2 08:54:59 INFO - jsonschema == 2.5.1 08:54:59 INFO - manifestparser == 1.1 08:54:59 INFO - mozInstall == 1.12 08:54:59 INFO - mozcrash == 1.0 08:54:59 INFO - mozdebug == 0.1 08:54:59 INFO - mozdevice == 0.48 08:54:59 INFO - mozfile == 1.2 08:54:59 INFO - mozhttpd == 0.7 08:54:59 INFO - mozinfo == 0.9 08:54:59 INFO - mozleak == 0.1 08:54:59 INFO - mozlog == 3.4 08:54:59 INFO - moznetwork == 0.27 08:54:59 INFO - mozprocess == 0.23 08:54:59 INFO - mozprofile == 0.28 08:54:59 INFO - mozrunner == 6.13 08:54:59 INFO - mozscreenshot == 0.1 08:54:59 INFO - mozsystemmonitor == 0.3 08:54:59 INFO - moztest == 0.8 08:54:59 INFO - mozversion == 1.4 08:54:59 INFO - psutil == 3.1.1 08:54:59 INFO - requests == 1.2.3 08:54:59 INFO - wsgiref == 0.1.2 08:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:54:59 INFO - Using env: {'DISPLAY': ':0', 08:54:59 INFO - 'HOME': '/home/cltbld', 08:54:59 INFO - 'LANG': 'en_US.UTF-8', 08:54:59 INFO - 'LANGUAGE': 'en_US:en', 08:54:59 INFO - 'LOGNAME': 'cltbld', 08:54:59 INFO - 'MAIL': '/var/mail/cltbld', 08:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:59 INFO - 'MOZ_NO_REMOTE': '1', 08:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:59 INFO - 'NO_EM_RESTART': '1', 08:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:59 INFO - 'PWD': '/builds/slave/test', 08:54:59 INFO - 'SHELL': '/bin/bash', 08:54:59 INFO - 'SHLVL': '1', 08:54:59 INFO - 'TERM': 'linux', 08:54:59 INFO - 'TMOUT': '86400', 08:54:59 INFO - 'USER': 'cltbld', 08:54:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:59 INFO - '_': '/tools/buildbot/bin/python'} 08:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:54:59 INFO - Cleaning up... 08:54:59 INFO - Return code: 0 08:54:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4afe714f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x269a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2767ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:54:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:54:59 INFO - Using env: {'DISPLAY': ':0', 08:54:59 INFO - 'HOME': '/home/cltbld', 08:54:59 INFO - 'LANG': 'en_US.UTF-8', 08:54:59 INFO - 'LANGUAGE': 'en_US:en', 08:54:59 INFO - 'LOGNAME': 'cltbld', 08:54:59 INFO - 'MAIL': '/var/mail/cltbld', 08:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:59 INFO - 'MOZ_NO_REMOTE': '1', 08:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:59 INFO - 'NO_EM_RESTART': '1', 08:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:59 INFO - 'PWD': '/builds/slave/test', 08:54:59 INFO - 'SHELL': '/bin/bash', 08:54:59 INFO - 'SHLVL': '1', 08:54:59 INFO - 'TERM': 'linux', 08:54:59 INFO - 'TMOUT': '86400', 08:54:59 INFO - 'USER': 'cltbld', 08:54:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:59 INFO - '_': '/tools/buildbot/bin/python'} 08:54:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:54:59 INFO - Cleaning up... 08:54:59 INFO - Return code: 0 08:54:59 INFO - Running post-action listener: _resource_record_post_action 08:54:59 INFO - Running post-action listener: _start_resource_monitoring 08:54:59 INFO - Starting resource monitoring. 08:54:59 INFO - [mozharness: 2017-01-18 16:54:59.927651Z] Finished create-virtualenv step (success) 08:54:59 INFO - [mozharness: 2017-01-18 16:54:59.928115Z] Running install step. 08:54:59 INFO - Running pre-action listener: _resource_record_pre_action 08:54:59 INFO - Running main action method: install 08:54:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:00 INFO - Reading from file tmpfile_stdout 08:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:00 INFO - Reading from file tmpfile_stdout 08:55:00 INFO - Output received: 08:55:00 INFO - Usage: mozinstall [options] installer 08:55:00 INFO - Options: 08:55:00 INFO - -h, --help show this help message and exit 08:55:00 INFO - -d DEST, --destination=DEST 08:55:00 INFO - Directory to install application into. [default: 08:55:00 INFO - "/builds/slave/test"] 08:55:00 INFO - --app=APP Application being installed. [default: firefox] 08:55:00 INFO - mkdir: /builds/slave/test/build/application 08:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:55:16 INFO - Reading from file tmpfile_stdout 08:55:16 INFO - Output received: 08:55:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:16 INFO - Running post-action listener: _resource_record_post_action 08:55:16 INFO - [mozharness: 2017-01-18 16:55:16.182545Z] Finished install step (success) 08:55:16 INFO - [mozharness: 2017-01-18 16:55:16.182785Z] Running run-tests step. 08:55:16 INFO - Running pre-action listener: _resource_record_pre_action 08:55:16 INFO - Running main action method: run_tests 08:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:16 INFO - Python 2.7.3 08:55:16 INFO - Return code: 0 08:55:16 INFO - grabbing minidump binary from tooltool 08:55:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2764f60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2765d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27661d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:55:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:55:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:55:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:16 INFO - Return code: 0 08:55:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:55:16 INFO - Using env: {'DISPLAY': ':0', 08:55:16 INFO - 'HOME': '/home/cltbld', 08:55:16 INFO - 'LANG': 'en_US.UTF-8', 08:55:16 INFO - 'LANGUAGE': 'en_US:en', 08:55:16 INFO - 'LOGNAME': 'cltbld', 08:55:16 INFO - 'MAIL': '/var/mail/cltbld', 08:55:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:16 INFO - 'MOZ_NO_REMOTE': '1', 08:55:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:16 INFO - 'NO_EM_RESTART': '1', 08:55:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:16 INFO - 'PWD': '/builds/slave/test', 08:55:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:16 INFO - 'SHELL': '/bin/bash', 08:55:16 INFO - 'SHLVL': '1', 08:55:16 INFO - 'TERM': 'linux', 08:55:16 INFO - 'TMOUT': '86400', 08:55:16 INFO - 'USER': 'cltbld', 08:55:16 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493', 08:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:16 INFO - '_': '/tools/buildbot/bin/python'} 08:55:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:55:16 INFO - mozversion application_buildid: 20170118070027 08:55:16 INFO - mozversion application_changeset: 27643a39e551670484fe7dd5836aaa01d66b9a7b 08:55:16 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:55:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:16 INFO - mozversion application_name: Firefox 08:55:16 INFO - mozversion application_remotingname: firefox-dev 08:55:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:55:16 INFO - mozversion application_vendor: Mozilla 08:55:16 INFO - mozversion application_version: 52.0a2 08:55:16 INFO - mozversion platform_buildid: 20170118070027 08:55:16 INFO - mozversion platform_changeset: 27643a39e551670484fe7dd5836aaa01d66b9a7b 08:55:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:55:16 INFO - mozversion platform_version: 52.0a2 08:55:16 INFO - using testdate: 1484758516 08:55:16 INFO - actual date: 1484758516 08:55:16 INFO - starting webserver on 'localhost:60869' 08:55:16 INFO - SUITE-START | Running 2 tests 08:55:16 INFO - TEST-START | dromaeo_css 08:55:16 INFO - operating with platform_type : linux_ 08:55:16 INFO - Initialising browser for dromaeo_css test... 08:55:16 INFO - TEST-INFO | started process 28517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjHwwv/profile http://localhost:60869/getInfo.html) 08:55:20 INFO - PROCESS | 28517 | __metrics Screen width/height:1600/1200 08:55:20 INFO - PROCESS | 28517 | colorDepth:24 08:55:20 INFO - PROCESS | 28517 | Browser inner width/height: 1024/697 08:55:20 INFO - PROCESS | 28517 | __metrics 08:55:21 INFO - PROCESS | 28517 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:55:21 INFO - PROCESS | 28517 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:21 INFO - PROCESS | 28517 | console.error: PushService: 08:55:21 INFO - PROCESS | 28517 | stateChangeProcessEnqueue: Error transitioning state 08:55:21 INFO - PROCESS | 28517 | UnknownError 08:55:22 INFO - TEST-INFO | 28517: exit 0 08:55:22 INFO - Browser initialized. 08:55:22 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:22 INFO - TEST-INFO | started process 28611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHjHwwv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:34 INFO - PROCESS | 28611 | RSS: Main: 143958016 08:55:34 INFO - PROCESS | 28611 | 08:58:36 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60869/tests/dromaeo/cssquery-ext.html) 08:58:37 INFO - PROCESS | 28611 | RSS: Main: 247435264 08:58:37 INFO - PROCESS | 28611 | 09:01:39 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-ext.html (next: http://localhost:60869/tests/dromaeo/cssquery-jquery.html) 09:01:40 INFO - PROCESS | 28611 | RSS: Main: 221155328 09:01:40 INFO - PROCESS | 28611 | 09:04:42 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60869/tests/dromaeo/cssquery-mootools.html) 09:04:42 INFO - PROCESS | 28611 | RSS: Main: 217034752 09:04:42 INFO - PROCESS | 28611 | 09:07:44 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60869/tests/dromaeo/cssquery-prototype.html) 09:07:45 INFO - PROCESS | 28611 | RSS: Main: 199004160 09:07:45 INFO - PROCESS | 28611 | 09:10:47 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60869/tests/dromaeo/cssquery-yui.html) 09:10:48 INFO - PROCESS | 28611 | RSS: Main: 176275456 09:10:48 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | Cycle 1(1): loaded http://localhost:60869/tests/dromaeo/cssquery-yui.html (next: http://localhost:60869/tests/dromaeo/cssquery-dojo.html) 09:13:51 INFO - PROCESS | 28611 | RSS: Main: 266530816 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | __start_tp_report 09:13:51 INFO - PROCESS | 28611 | _x_x_mozilla_page_load 09:13:51 INFO - PROCESS | 28611 | _x_x_mozilla_page_load_details 09:13:51 INFO - PROCESS | 28611 | |i|pagename|runs| 09:13:51 INFO - PROCESS | 28611 | |0;dojo.html;3174.5555622212887;3207.4868021116617;3209.5667084943525;3224.532442795795;3260.75544334175;5495.6153069285165;5605.411431799658;5622.803201887929;5624.465675760796;5630.5495560355175;5594.076977298751;5652.689102099383;5658.43415658434;5661.745221465034;5687.289088863892;5088.4911508849;5106.183010718286;5138.66598671087;5160.716160611165;5188.948110518903;4940.530649588283;4947.9505204947845;5180.559652429529;5203;5204.0372531081875;5094.133997220481;5115.897682046376;5132.692038477685;5140.228965655163;5152.845414637567;5158.071547121516;5169.948300516984;5233.5551478124025;5240.266362709223;5251.396089449686;4946.1344264753525;4947.431045429786;5150.613703972217;5171.7672704728375;5222.63441559091;5473.425290344497;5512.062949298629;5521.089020311644;5526.419725928759;5537.861553461155;5965.13505541694;5997.130416089686;6014.669193194372;6014.879702405928;6017.819465416001;5850.23946886902;5888.735006924699;6076.605020673642;6093.847653808646;6100.664463454508;5620.662760234358;5643.887122257573;5667.8583035424035;5713.371529131792;5714.628549144292;6242.531810114168;6261.843453913689;6262.5616206866;6264.968675156595;6265.71804268809;5780.075187969988;5836.795712150054;6008.939910600925;6015.0977353396465;6024.096385542204;5912.704364781744;5954.374790647006;5964.403559644001;6000.5799594028;6037.577369584087;5946.345901950782;5960.225170727777;5964.254468191476;5967.254093238345;5973.342932277446;5727.255456790674;5948.345681974979;5987.850303742354;5989.041753319448;5990.161377407167;4491.146682130385;4527.230370836965;4581.335706322565;4585.358049873021;4638.976805115953;4080.9795951020055;4094.324436468009;4098.713090083726;4116.197341518375;4120.196561670506;5707.315122185364;5714.399988001283;5715.914261286084;5716.885662286731;5744.109663002241;5789.160571717078;5856.765729370863;5947.6431414115295;5950.642961422329;5994.580379373489;5710.7430165642645;5717.313922329347;5717.456841600041;5718;5738.110592858114;5171.81898633546;5174.146265866165;5177.223416487557;5177.896442071137;5221.347331583552;6042.788502402483;6113.871604717359;6115.082737589397;6233.470155036873;6279.089532017923;6020.217371741645;6057.818265451867;6059;6079.422454866781;6088.817335479943;6270.592411493239;6274;6274.592151510137;6276.089966954857;6290.402411770874;5638.887222255614;5744.310682718101;5955.642661440327;5965.194698715618;5995.970020149872;5909.143174239625;6019.849503762441;6032.819015429544;6095.207623008981;6134.447899689049;5894.528437725057;5934.080217566284;5967.31375891778;5969.04495280753;5974.880502390015;5562.833115006556;5942.108683697307;5948.40515948419;5948.583599148191;5949.762009519571;5645.379008309001;5825.737841797214;5881.088431293157;5890.734916928663;5942.316633587193;5930.318013428338;5964.045752679551;5966.015607424726;5968.22413086296;5973.701314934323;5587.245721827501;5641.097424412074;5648.915266270927;5699.971500142473;5805.071188609971 09:13:51 INFO - PROCESS | 28611 | |1;ext.html;583.0641819879094;601.2484394506866;621.8165641135864;645.6868418816873;663.4824836627432;34100.14749631257;36996.260074798556;37088.07279818006;37153.81423092884;37466.25067498652;37579.62420375796;47085.293720594134;47783.52216477834;47914.76042619782;51946.22080668793;8817.11828817118;8940.329475289347;8953.597088131017;8959.686410975617;8960.551972401387;8322.625481853302;8486.53324067176;8909.73270801877;8999.23506501948;9001.729948101567;10550.525226364833;10863.565457381696;10867.456627168649;11197.832032519518;11205.21563490556;10528.78942421151;10584.206184536191;10599.311044782064;10606.204534659932;10607.045365917027;10628.256022078458;10691.358518488838;10705.946470267676;10711;10716.946415267874;43944.3408348875;43975.78012109951;44140.3378949316;44387;44426.55573444256;3703.0742314421395;3727.329080765461;3731.794751288678;3757.6618104370737;3780.3006443807985;32842.01473955785;32901.3419731604;33126.17184570381;33408.33183336344;33984.6601533984;4429.357743127229;4488.842890498817;4517.683762136652;4522.886927826798;4580.038191979688;359141;368390;368577;490323;496578;61447.69276153591;61555.07667384993;61783.69108154521;61845.69077154585;61889.690551546955;40102;66660;66702.33297667059;66825;66933.33066669368;17356.218970146372;17434.651306974043;17441.912790435967;17451.91274043647;17482.125893705263;14046.929765351108;14135.78796318056;14170.645733856736;14170.645733856736;14171.503997360249;18245.7263141053;18272.908635456737;20004.099815508336;20163.99180040992;20365.59268814645;7154.027950574301;7193.424526037905;7232.168300645388;7246.384057355079;7524.291255148142;980.3872579637726;1015.619142821442;1027.3322340478749;1029.3926583315729;1105.27604419104;32783.1804204892;33412.1646958828;33553.328933421195;33604.159896002304;34102.65897341044;1036.3212096077082;1114.1365441782684;1125.7129431994788;1136.7158210447387;1180.3729380827008;15183;16210.75683864743;16411;16823.747643785355;17548.2103305349;530606;530815;531444;532321;532690;55574;56676;60373.69813150994;61406;61419.38580614136;1369.459063669845;1393.2406838273166;1397.7693680543002;1400.9649758755909;1408.9013769036274;31999.680003200603;34629.30741385208;34734.13164670904;34745.478817817246;34772.38534578155;55073;55415.44584554103;55581.44418555763;55598.44401556095;55635;429480;430577;432106;432954;434126;30875.69124308728;30904;31056.534151987285;31161.37677246488;31436;50208.74895625498;50454.747726261136;50617.24074138964;50644.49355506398;51478;41421.378679320434;41739;42857.35713964231;44163.55836441723;45039;41211;41335.37996930109;41669.58330416657;42464.57535424606;42952.57047429486;41880.58119418767;42548.78725606352;42731.14537709291;43193.3520997179;43418.56581434271;31072.53391199179;32757.344853102328;34407.31185376328;34422.48366274458;34499.310013799084;25606.48787024212;26297;26311.605325919743;26418.867905660347;26496.56037512317 09:13:51 INFO - PROCESS | 28611 | |2;jquery.html;389.2273836434678;408.65468678966283;420.31278859065424;424.4100700026962;426.31150691633;14675.559733207994;16604.169791510423;19493.220271189137;19856.99999999998;20690.68963965538;19169.233230670758;19499.512512187168;19655.115519801606;20026.49933751657;20233.49416264594;5629.380768115504;5665.3078289955065;5720.170575266584;5825.621334613258;5839.737211825457;4384.386185933972;4509.594136527712;5702.543796496291;5783.450572195635;5795.4784069433745;4526.049529598772;4535.206338890697;6160.815175544741;6403.359664033606;6415.839604009914;5547.916781248305;5760.279965004374;5796.50729687977;6495.837604059889;6531.248906375757;5612.242347283105;5660.377358490604;5663.348714897798;5663.490285874291;5665.801696940587;13631.386587603582;13683.521076762365;13918.860811391958;13943.511977080854;13950.372233249427;2317.4901521665374;2386.2721869829693;2463.1379017343966;2526.621006848969;2806.663200415943;10098.646547370807;10202.489875506195;10431.582736690523;10501.474926253657;11013.118950483942;1920.875143115693;2010.095457044336;2010.2763005318075;2037.4397040813747;2047.8873661948735;80695;83576;84361;85561;90513;9352.812943741086;9761.560729767178;9780.23955687983;9811.430171172578;9818.90181098194;13021.218726876228;13116.934415327862;13132.671683207996;13137.080404371602;13139.145955513051;7853;7966.322862556632;8003.799905002422;8191.79520511992;8216.301614362726;8337.166283371615;8342.332613390914;8458.746237612759;8535.615897284637;8560;3842.654161125512;3994.1412596291357;4019.2765302245875;4030.5969403059457;4262.50981137167;1840.438666206793;1844.2807305151002;1890.4234208566245;1891.3191251149576;1894.981050189508;932.2169377722745;956.4404823178379;958.4584709639032;996.1582462818907;1033.0857191385528;18988.81011189898;19032.71450928237;19586.31447899317;19903.900480497505;20839.479013024797;953.2032119454739;966.2559828931824;986.3095832916987;990.945497997617;994.5773046455228;10227.590896364061;10803.567857285621;11013.063889569476;11125.44372781374;11129;444584;449227;449736;456182;458302;56319.71840140855;88293.55853220822;91293;94769.5261523688;99415.50292248493;992.0525897767615;1019.0675531888387;1023.8720159980003;1031.200819364998;1036.1141224253156;17194;17350.826491734922;17438.651226975137;17447.651046978735;17865.374711885022;42010;42465;42520.57479425166;43503.12993740171;45009.549904500534;54938.725306374814;58961;59762;59890;60987.695061524406;6518.282988871315;7942;8226.794330141794;8402.453840500348;8498.235158835734;12239.553513195913;12243.265404075428;12993.740125197632;13072.084954053125;13086.672833178865;11050.33697978124;11052.613158539412;11093.278936869077;11401.600943966921;11736.237144585575;11140.665780026613;11262.605808796652;11387.373694446553;11398.772024559297;11408.657740267805;10718.08896243828;11081.944590276997;11154.776904462027;11154.944225279147;11495.827562586735;8131.634076466455;8186.140455252351;8265.628046737791;8350.958245208734;8661.696840610548;8562.52906090171;10582;10970.945145274223;11086.22396432242;11360.488778004845 09:13:51 INFO - PROCESS | 28611 | |3;mootools.html;1353.1678018018922;1461.298576683192;1477.7266205751937;1640.3520609359302;1796.470041337806;6918.446524278058;7440.255974402557;7880.448368614199;7883.329916957051;7893.763187104381;7721.961390193042;7857;7859.842803143933;8072.55600941948;8073;2297.1041293895396;2327.162221600231;2327.767223277676;2327.8137748980125;2335.4861930375373;2331.63859601762;2382.4282172278704;2400.6879105716234;2404.5791986402396;2405.6271277951946;2307.1002309099463;2320.245920075982;2333.8599684018927;2336.7663233676667;2342.0163531316803;2291.8281128915232;2297.8161747060194;2319.3042087373806;2320.501092265154;2332.428555004018;2298.5288015956858;2315.9421014474774;2317.617593097137;2319.3621754017613;2320.501092265171;7741.419393545507;7820.765377038698;7921.603919803987;7968.04383473981;7971.72098976533;4861.538153875376;4989.426215985136;5002.499750025005;5007.37407824022;5009.348784658007;3273.7544684148784;3330.4837750148768;3348.4049861357644;3351.379994700988;3377.189474526096;1034.865467489229;1047.2721458586286;1062.6493257225097;1086.0876863434753;1099.274478843959;10584.576616935314;10752.73118172044;10819.350838949687;10891.128709703284;10896.891031089666;4192.895177620523;4314.805833737427;4328.372386004012;4399.758013309299;4404.7357158570585;9302.488363140092;9313.068693130634;9317.16145546904;9322.487263200454;9324.487153206503;5000.649954503223;5024.572911302507;5041.319421878;5042.369703787027;5046.167382381939;4135.648469880034;4222.387753775747;4260.68044896634;4577.404937358122;4600.884977875513;3882;3934.5278566571624;3985.780782056957;4007.6192761688176;4031.677465802729;1229.170310040737;1234.2964510229083;1240.1133189769357;1248.3383806582526;1252.6868282929267;920.5673333533229;928.8467402878449;943.2454036770556;953.774399896144;980.4068538534227;5196.8960620787375;5397.811076612378;5429.701366424805;5570.303712035996;5622.718864056781;401.8272142978547;403.8303912356817;404.953430355507;411.1263564924535;414.87968489138416;3744.5693745219105;3952.130531283113;3955.723099383073;3958.9208215835524;4074.246264441088;9319.347645664739;9471.384360016715;9644.18024467928;9709;9711.36876103051;9465.668701595549;9627;9660.613575457044;9665.613375464902;9665.90334096664;7557.811054723566;7742.922570774333;7743.186965368555;7745.186755390716;7746.922530774733;5509.889802204014;5517.117261238182;5540.667559946416;5649.039663257174;5654.575906807088;8863.734087977371;8900.243479304332;9011.864822027806;9024;9024.278057755233;9090.272778177598;9182.632694692405;9188.862167067366;9195.724128276162;9201.953990230273;6597.27429982692;6767.221769496374;6933.653317334214;7255.709771609077;7337.119545654556;7631.3894888407685;7906.9209307906185;7909.960450197712;7912.643931023003;7913.366930645419;6867.725290988505;6908.067410899464;6967.303269673195;6971.616561088986;7014.158301003912;6527.412532871875;6644.933550664625;7047.682854271673;7157.606331651809;7199.1361036675935;6100.26796784371;6233.314335423191;6300.9684951574945;6307.842303942438;6400.647964361819;4560.247559152703;4567.588916997486;4891.90216195667;4958.776855041604;4988.625853061108;4993.126202914403;5046.545810877039;5103.795848166032;5143.974280128576;5164.32863727713 09:13:51 INFO - PROCESS | 28611 | |4;prototype.html;330.54549993758565;331.5077110490921;333.2119537294298;337.21597286309327;344.9275652113056;5106.136260265004;5172;5281.788728450862;5293.788248470061;5293.814716484924;5062.898742025157;5157.458466860982;5180.507851754077;5199.376074871021;5206.802435439851;4115.855945041924;4128.318827393491;4131.400946862711;4135.234981528427;4180.665546756252;3935.8425662973445;4092.5907409259135;4163.854265100722;4169.166166766644;4174;4055.3105971984687;4064.248114098886;4072.2669919414493;4073.775942323171;4076.164386300816;4063.6952228582827;4069.232921613287;4075.3886916962397;4103.138340948404;4113.9794301028605;3480.955713286004;3571.94642080369;3575.5173051638217;3579.785212887235;3620.945685814715;5020.924686129711;5042.747862606891;5070.543651071422;5081.491850814926;5094.5160209780015;4560.973780899304;4590.60979816716;4602.148602508513;4606.7887414041115;4614.007988282502;5181.715005674687;5394.91907621386;5399.352077750656;5419.566434685215;5464;3936.893761837432;3943.585923478051;3943.861964831246;3957;3962.425448309979;5681.460261275172;5701.401352857932;5702.885942281173;5706.146926536731;5747.511461525817;3922.5685174630767;4021.658159056513;4048.372502262095;4069.3895915612893;4071.572484889103;4055.7972101395403;4064.166845796605;4064.288749468831;4076.7146299758733;4079.918401631951;4598.609118224921;4602.930956035662;4604.40142781443;4630.629549636021;4638.234691275969;5314.1497360422145;5423.349198096174;5447.237386765856;5472.863178420572;5483.683915860165;1345.5156143788229;1348.1371921969946;1351.9589915764807;1353.4518519999417;1365.6381059019368;917.312015988009;933.3466573398648;948.6347756113807;954.9877130241965;959.0649117110761;5021.899562008813;5038.722870242172;5039.538533825223;5041.974790126026;5053.393592768891;5233.973830130825;5249.317588713443;5265.3944796348915;5330.466953304638;5367.651102678392;4833.419989601271;5044;5066.60668316216;5070.29015937769;5102.668326558762;2808.5365914624267;2846.0892514395196;2857.8856845726355;2890.8699108539745;2896.029830006929;5578.693171875505;5587.8882422352135;5615.326160860723;5635.21107045014;5649.209110724501;5244.711540865213;5410.3507579090765;5421.457854214547;5464.295173888951;5541.4811594637695;5512.80705175317;5522.861928451821;5523.392426833045;5561.277033985637;5566.133441277745;5188.221766734869;5350.866228344167;5384.4346343634925;5390.757415916215;5400.9459905400445;5302.310699609026;5306.461126273492;5329.520343169133;5342.225377320189;5354.732263386737;5540.418256083053;5550.500454958911;5558.916616250679;5569.860753481195;5602.579806514609;3864.46877295372;3919.529656441245;3947.921041579095;3950.2889479893897;3984.8206830693266;5531.170324451365;5567.164925261081;5572.3034620672415;5588.888222235614;5591.776328946797;5481.150421684645;5481.424450432647;5488.286522752017;5495.560355171657;5499.862503437446;5251.396089449762;5404.54061404785;5420.457954204706;5420.810271640474;5427.83716488506;5395.487428694268;5397.139516056496;5447.155690867922;5469.9179512306555;5474.753636086306;5345.866353341197;5448.863778405572;5508.20131080983;5522.061249587499;5528.751206195811;5275.525202731619;5306.363236411656;5326.493983071602;5333.013392522395;5336.973315133399 09:13:51 INFO - PROCESS | 28611 | |5;yui.html;760.3271105072009;788.9250521200488;799.2886331165261;846.8433339832134;850.9659613615456;15590;15886.523404297875;16249.268782904754;16584.419545315915;16734.58163545912;15396.84603153968;15728.134952577604;16401.343946242137;16563;16571.50285491437;842.7134774176794;850.6980022092162;852.382023033299;852.526847599582;853.7865533616596;723.5369363607296;730.426615107141;845.602566793606;862.3877047296427;866.7096522664883;909.4225167018924;911.3483859040784;912.0788004115858;912.4114945859916;912.4570880326195;898.2723993565168;903.1510380242617;907.0566610724871;907.5598334807613;907.9909200908005;548.7859734703469;561.2255087978564;648.6626953983949;649.0556240669814;658.1904257762978;14451.349689264009;14574.344154513072;14611.48859789913;14630.268486575735;14633.048851824597;13395.531156409575;13535.18788872661;13571.117877337942;13586.59240222785;13659.658508537266;13075.542356017493;13184.40670169835;13198.73602527944;13258.40337184829;13271.668208294774;4439.578240067189;4454.910901781946;4459.130469558438;4468.597826195625;4583.9541604583865;57441.425585744444;58864.411355886325;59561.702191489196;66410;66804.6659766698;11683;11761;11829.585964491202;11893.940530297294;12199.085068619888;20620.69068963967;20686.896565517378;20701;20722.896385518277;20741.066652000696;8801;8850.73447796567;9022.14289642483;9081.45511269326;9251.861222081674;4851.151048566487;4877.707337559757;4933.55597996182;4986.102501549683;5086.491350864958;3440;3575.5530558680166;3575.910602234913;3577.7853328799833;3594.227241143167;646.1051443750439;659.5053709717712;660.1451120798578;666.5534092158266;675.2268652392983;644.5294934697697;652.360686527206;658.9868202636017;728.9161746399126;751.5678484871221;9406.764830879283;9537.427754334762;9667.27495437845;9875;10323.94838025805;677.664556044761;704.4188544450849;731.2102928836844;739.183202561173;748.468587303021;4469.217886869785;4595.701279416827;4628.675992680547;4680.160815221764;4842;68547.65726171437;93454.53272733728;95846.52076739712;96052;99424.50287748515;67580.66209668921;68781.65609171923;81590;82659;85064;58882.41117588769;66405.33594663991;66933.33066669271;68359;70946.64526677334;8884.822303554021;9153.313501487548;9944.701658950244;10142.797144057226;10289.794204115726;34863.47704784379;41240.587594124874;47453.52546474491;47743.522564773906;48188.75905620449;39187.216255675296;44597.55402445934;62711;63041.36958630355;65941.04353738792;12054.939725301318;12188.57339993096;12344.4444999977;12537.749245014866;12570.748585028432;14420.927895360455;14725.337359819048;14770.704585908437;14963.476278330207;15231.314590843216;13434.731305374033;13572.321383930961;14391;14446.133232006114;14674.33965471535;13415.195088294733;13668.794968075288;13815.171089734647;13961.650958726113;14046.859531404963;12899.613011609667;12977.740445190855;13092.738145236852;13159.934200328937;13299.26854023038;10412.32319899204;10865.565377384815;11050;11106.444677765918;11248.606298779503;9688.321817472992;10685.145188385066;10695.197860160675;10716.57133714674;10853.511591978538 09:13:51 INFO - PROCESS | 28611 | __end_tp_report 09:13:51 INFO - PROCESS | 28611 | __start_cc_report 09:13:51 INFO - PROCESS | 28611 | _x_x_mozilla_cycle_collect,1012 09:13:51 INFO - PROCESS | 28611 | __end_cc_report 09:13:51 INFO - PROCESS | 28611 | __startTimestamp1484759631382__endTimestamp 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | ------- Summary: start ------- 09:13:51 INFO - PROCESS | 28611 | Number of tests: 6 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#0] dojo.html Cycles:165 Average:5583.38 Median:5744.11 stddev:640.22 (11.1%) stddev-sans-first:613.66 09:13:51 INFO - PROCESS | 28611 | Values: 3174.6 3207.5 3209.6 3224.5 3260.8 5495.6 5605.4 5622.8 5624.5 5630.5 5594.1 5652.7 5658.4 5661.7 5687.3 5088.5 5106.2 5138.7 5160.7 5188.9 4940.5 4948.0 5180.6 5203.0 5204.0 5094.1 5115.9 5132.7 5140.2 5152.8 5158.1 5169.9 5233.6 5240.3 5251.4 4946.1 4947.4 5150.6 5171.8 5222.6 5473.4 5512.1 5521.1 5526.4 5537.9 5965.1 5997.1 6014.7 6014.9 6017.8 5850.2 5888.7 6076.6 6093.8 6100.7 5620.7 5643.9 5667.9 5713.4 5714.6 6242.5 6261.8 6262.6 6265.0 6265.7 5780.1 5836.8 6008.9 6015.1 6024.1 5912.7 5954.4 5964.4 6000.6 6037.6 5946.3 5960.2 5964.3 5967.3 5973.3 5727.3 5948.3 5987.9 5989.0 5990.2 4491.1 4527.2 4581.3 4585.4 4639.0 4081.0 4094.3 4098.7 4116.2 4120.2 5707.3 5714.4 5715.9 5716.9 5744.1 5789.2 5856.8 5947.6 5950.6 5994.6 5710.7 5717.3 5717.5 5718.0 5738.1 5171.8 5174.1 5177.2 5177.9 5221.3 6042.8 6113.9 6115.1 6233.5 6279.1 6020.2 6057.8 6059.0 6079.4 6088.8 6270.6 6274.0 6274.6 6276.1 6290.4 5638.9 5744.3 5955.6 5965.2 5996.0 5909.1 6019.8 6032.8 6095.2 6134.4 5894.5 5934.1 5967.3 5969.0 5974.9 5562.8 5942.1 5948.4 5948.6 5949.8 5645.4 5825.7 5881.1 5890.7 5942.3 5930.3 5964.0 5966.0 5968.2 5973.7 5587.2 5641.1 5648.9 5700.0 5805.1 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#1] ext.html Cycles:180 Average:62554.98 Median:20668.64 stddev:122972.33 (595.0%) stddev-sans-first:123229.27 09:13:51 INFO - PROCESS | 28611 | Values: 583.1 601.2 621.8 645.7 663.5 34100.1 36996.3 37088.1 37153.8 37466.3 37579.6 47085.3 47783.5 47914.8 51946.2 8817.1 8940.3 8953.6 8959.7 8960.6 8322.6 8486.5 8909.7 8999.2 9001.7 10550.5 10863.6 10867.5 11197.8 11205.2 10528.8 10584.2 10599.3 10606.2 10607.0 10628.3 10691.4 10705.9 10711.0 10716.9 43944.3 43975.8 44140.3 44387.0 44426.6 3703.1 3727.3 3731.8 3757.7 3780.3 32842.0 32901.3 33126.2 33408.3 33984.7 4429.4 4488.8 4517.7 4522.9 4580.0 359141.0 368390.0 368577.0 490323.0 496578.0 61447.7 61555.1 61783.7 61845.7 61889.7 40102.0 66660.0 66702.3 66825.0 66933.3 17356.2 17434.7 17441.9 17451.9 17482.1 14046.9 14135.8 14170.6 14170.6 14171.5 18245.7 18272.9 20004.1 20164.0 20365.6 7154.0 7193.4 7232.2 7246.4 7524.3 980.4 1015.6 1027.3 1029.4 1105.3 32783.2 33412.2 33553.3 33604.2 34102.7 1036.3 1114.1 1125.7 1136.7 1180.4 15183.0 16210.8 16411.0 16823.7 17548.2 530606.0 530815.0 531444.0 532321.0 532690.0 55574.0 56676.0 60373.7 61406.0 61419.4 1369.5 1393.2 1397.8 1401.0 1408.9 31999.7 34629.3 34734.1 34745.5 34772.4 55073.0 55415.4 55581.4 55598.4 55635.0 429480.0 430577.0 432106.0 432954.0 434126.0 30875.7 30904.0 31056.5 31161.4 31436.0 50208.7 50454.7 50617.2 50644.5 51478.0 41421.4 41739.0 42857.4 44163.6 45039.0 41211.0 41335.4 41669.6 42464.6 42952.6 41880.6 42548.8 42731.1 43193.4 43418.6 31072.5 32757.3 34407.3 34422.5 34499.3 25606.5 26297.0 26311.6 26418.9 26496.6 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#2] jquery.html Cycles:180 Average:27482.38 Median:21215.16 stddev:74779.96 (352.5%) stddev-sans-first:74962.07 09:13:51 INFO - PROCESS | 28611 | Values: 389.2 408.7 420.3 424.4 426.3 14675.6 16604.2 19493.2 19857.0 20690.7 19169.2 19499.5 19655.1 20026.5 20233.5 5629.4 5665.3 5720.2 5825.6 5839.7 4384.4 4509.6 5702.5 5783.5 5795.5 4526.0 4535.2 6160.8 6403.4 6415.8 5547.9 5760.3 5796.5 6495.8 6531.2 5612.2 5660.4 5663.3 5663.5 5665.8 13631.4 13683.5 13918.9 13943.5 13950.4 2317.5 2386.3 2463.1 2526.6 2806.7 10098.6 10202.5 10431.6 10501.5 11013.1 1920.9 2010.1 2010.3 2037.4 2047.9 80695.0 83576.0 84361.0 85561.0 90513.0 9352.8 9761.6 9780.2 9811.4 9818.9 13021.2 13116.9 13132.7 13137.1 13139.1 7853.0 7966.3 8003.8 8191.8 8216.3 8337.2 8342.3 8458.7 8535.6 8560.0 3842.7 3994.1 4019.3 4030.6 4262.5 1840.4 1844.3 1890.4 1891.3 1895.0 932.2 956.4 958.5 996.2 1033.1 18988.8 19032.7 19586.3 19903.9 20839.5 953.2 966.3 986.3 990.9 994.6 10227.6 10803.6 11013.1 11125.4 11129.0 444584.0 449227.0 449736.0 456182.0 458302.0 56319.7 88293.6 91293.0 94769.5 99415.5 992.1 1019.1 1023.9 1031.2 1036.1 17194.0 17350.8 17438.7 17447.7 17865.4 42010.0 42465.0 42520.6 43503.1 45009.5 54938.7 58961.0 59762.0 59890.0 60987.7 6518.3 7942.0 8226.8 8402.5 8498.2 12239.6 12243.3 12993.7 13072.1 13086.7 11050.3 11052.6 11093.3 11401.6 11736.2 11140.7 11262.6 11387.4 11398.8 11408.7 10718.1 11081.9 11154.8 11154.9 11495.8 8131.6 8186.1 8265.6 8351.0 8661.7 8562.5 10582.0 10970.9 11086.2 11360.5 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#3] mootools.html Cycles:180 Average:5311.35 Median:5046.36 stddev:2883.52 (57.1%) stddev-sans-first:2876.26 09:13:51 INFO - PROCESS | 28611 | Values: 1353.2 1461.3 1477.7 1640.4 1796.5 6918.4 7440.3 7880.4 7883.3 7893.8 7722.0 7857.0 7859.8 8072.6 8073.0 2297.1 2327.2 2327.8 2327.8 2335.5 2331.6 2382.4 2400.7 2404.6 2405.6 2307.1 2320.2 2333.9 2336.8 2342.0 2291.8 2297.8 2319.3 2320.5 2332.4 2298.5 2315.9 2317.6 2319.4 2320.5 7741.4 7820.8 7921.6 7968.0 7971.7 4861.5 4989.4 5002.5 5007.4 5009.3 3273.8 3330.5 3348.4 3351.4 3377.2 1034.9 1047.3 1062.6 1086.1 1099.3 10584.6 10752.7 10819.4 10891.1 10896.9 4192.9 4314.8 4328.4 4399.8 4404.7 9302.5 9313.1 9317.2 9322.5 9324.5 5000.6 5024.6 5041.3 5042.4 5046.2 4135.6 4222.4 4260.7 4577.4 4600.9 3882.0 3934.5 3985.8 4007.6 4031.7 1229.2 1234.3 1240.1 1248.3 1252.7 920.6 928.8 943.2 953.8 980.4 5196.9 5397.8 5429.7 5570.3 5622.7 401.8 403.8 405.0 411.1 414.9 3744.6 3952.1 3955.7 3958.9 4074.2 9319.3 9471.4 9644.2 9709.0 9711.4 9465.7 9627.0 9660.6 9665.6 9665.9 7557.8 7742.9 7743.2 7745.2 7746.9 5509.9 5517.1 5540.7 5649.0 5654.6 8863.7 8900.2 9011.9 9024.0 9024.3 9090.3 9182.6 9188.9 9195.7 9202.0 6597.3 6767.2 6933.7 7255.7 7337.1 7631.4 7906.9 7910.0 7912.6 7913.4 6867.7 6908.1 6967.3 6971.6 7014.2 6527.4 6644.9 7047.7 7157.6 7199.1 6100.3 6233.3 6301.0 6307.8 6400.6 4560.2 4567.6 4891.9 4958.8 4988.6 4993.1 5046.5 5103.8 5144.0 5164.3 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#4] prototype.html Cycles:180 Average:4539.58 Median:5184.97 stddev:1314.10 (25.3%) stddev-sans-first:1279.25 09:13:51 INFO - PROCESS | 28611 | Values: 330.5 331.5 333.2 337.2 344.9 5106.1 5172.0 5281.8 5293.8 5293.8 5062.9 5157.5 5180.5 5199.4 5206.8 4115.9 4128.3 4131.4 4135.2 4180.7 3935.8 4092.6 4163.9 4169.2 4174.0 4055.3 4064.2 4072.3 4073.8 4076.2 4063.7 4069.2 4075.4 4103.1 4114.0 3481.0 3571.9 3575.5 3579.8 3620.9 5020.9 5042.7 5070.5 5081.5 5094.5 4561.0 4590.6 4602.1 4606.8 4614.0 5181.7 5394.9 5399.4 5419.6 5464.0 3936.9 3943.6 3943.9 3957.0 3962.4 5681.5 5701.4 5702.9 5706.1 5747.5 3922.6 4021.7 4048.4 4069.4 4071.6 4055.8 4064.2 4064.3 4076.7 4079.9 4598.6 4602.9 4604.4 4630.6 4638.2 5314.1 5423.3 5447.2 5472.9 5483.7 1345.5 1348.1 1352.0 1353.5 1365.6 917.3 933.3 948.6 955.0 959.1 5021.9 5038.7 5039.5 5042.0 5053.4 5234.0 5249.3 5265.4 5330.5 5367.7 4833.4 5044.0 5066.6 5070.3 5102.7 2808.5 2846.1 2857.9 2890.9 2896.0 5578.7 5587.9 5615.3 5635.2 5649.2 5244.7 5410.4 5421.5 5464.3 5541.5 5512.8 5522.9 5523.4 5561.3 5566.1 5188.2 5350.9 5384.4 5390.8 5400.9 5302.3 5306.5 5329.5 5342.2 5354.7 5540.4 5550.5 5558.9 5569.9 5602.6 3864.5 3919.5 3947.9 3950.3 3984.8 5531.2 5567.2 5572.3 5588.9 5591.8 5481.2 5481.4 5488.3 5495.6 5499.9 5251.4 5404.5 5420.5 5420.8 5427.8 5395.5 5397.1 5447.2 5469.9 5474.8 5345.9 5448.9 5508.2 5522.1 5528.8 5275.5 5306.4 5326.5 5333.0 5337.0 09:13:51 INFO - PROCESS | 28611 | 09:13:51 INFO - PROCESS | 28611 | [#5] yui.html Cycles:180 Average:17882.88 Median:47598.52 stddev:23265.90 (48.9%) stddev-sans-first:23295.64 09:13:51 INFO - PROCESS | 28611 | Values: 760.3 788.9 799.3 846.8 851.0 15590.0 15886.5 16249.3 16584.4 16734.6 15396.8 15728.1 16401.3 16563.0 16571.5 842.7 850.7 852.4 852.5 853.8 723.5 730.4 845.6 862.4 866.7 909.4 911.3 912.1 912.4 912.5 898.3 903.2 907.1 907.6 908.0 548.8 561.2 648.7 649.1 658.2 14451.3 14574.3 14611.5 14630.3 14633.0 13395.5 13535.2 13571.1 13586.6 13659.7 13075.5 13184.4 13198.7 13258.4 13271.7 4439.6 4454.9 4459.1 4468.6 4584.0 57441.4 58864.4 59561.7 66410.0 66804.7 11683.0 11761.0 11829.6 11893.9 12199.1 20620.7 20686.9 20701.0 20722.9 20741.1 8801.0 8850.7 9022.1 9081.5 9251.9 4851.2 4877.7 4933.6 4986.1 5086.5 3440.0 3575.6 3575.9 3577.8 3594.2 646.1 659.5 660.1 666.6 675.2 644.5 652.4 659.0 728.9 751.6 9406.8 9537.4 9667.3 9875.0 10323.9 677.7 704.4 731.2 739.2 748.5 4469.2 4595.7 4628.7 4680.2 4842.0 68547.7 93454.5 95846.5 96052.0 99424.5 67580.7 68781.7 81590.0 82659.0 85064.0 58882.4 66405.3 66933.3 68359.0 70946.6 8884.8 9153.3 9944.7 10142.8 10289.8 34863.5 41240.6 47453.5 47743.5 48188.8 39187.2 44597.6 62711.0 63041.4 65941.0 12054.9 12188.6 12344.4 12537.7 12570.7 14420.9 14725.3 14770.7 14963.5 15231.3 13434.7 13572.3 14391.0 14446.1 14674.3 13415.2 13668.8 13815.2 13961.7 14046.9 12899.6 12977.7 13092.7 13159.9 13299.3 10412.3 10865.6 11050.0 11106.4 11248.6 9688.3 10685.1 10695.2 10716.6 10853.5 09:13:51 INFO - PROCESS | 28611 | -------- Summary: end -------- 09:13:51 INFO - PROCESS | 28611 | 09:13:52 INFO - TEST-INFO | 28611: exit 0 09:13:52 INFO - TEST-OK | dromaeo_css | took 1115742ms 09:13:52 INFO - TEST-START | kraken 09:13:52 INFO - operating with platform_type : linux_ 09:13:52 INFO - Initialising browser for kraken test... 09:13:52 INFO - TEST-INFO | started process 28933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXA6z6k/profile http://localhost:60869/getInfo.html) 09:13:56 INFO - PROCESS | 28933 | __metrics Screen width/height:1600/1200 09:13:56 INFO - PROCESS | 28933 | colorDepth:24 09:13:56 INFO - PROCESS | 28933 | Browser inner width/height: 1024/697 09:13:56 INFO - PROCESS | 28933 | __metrics 09:13:56 INFO - PROCESS | 28933 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:56 INFO - PROCESS | 28933 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:57 INFO - PROCESS | 28933 | console.error: PushService: 09:13:57 INFO - PROCESS | 28933 | stateChangeProcessEnqueue: Error transitioning state 09:13:57 INFO - PROCESS | 28933 | UnknownError 09:13:57 INFO - TEST-INFO | 28933: exit 0 09:13:57 INFO - Browser initialized. 09:13:57 INFO - Running cycle 1/1 for kraken test... 09:13:57 INFO - TEST-INFO | started process 29026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXA6z6k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:09 INFO - PROCESS | 29026 | RSS: Main: 143925248 09:14:09 INFO - PROCESS | 29026 | 09:14:12 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60869/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:12 INFO - PROCESS | 29026 | RSS: Main: 185679872 09:14:12 INFO - PROCESS | 29026 | 09:14:15 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60869/tests/kraken/driver.html?testName=audio-dft) 09:14:16 INFO - PROCESS | 29026 | RSS: Main: 174555136 09:14:16 INFO - PROCESS | 29026 | 09:14:18 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60869/tests/kraken/driver.html?testName=audio-fft) 09:14:19 INFO - PROCESS | 29026 | RSS: Main: 266534912 09:14:19 INFO - PROCESS | 29026 | 09:14:21 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60869/tests/kraken/driver.html?testName=audio-oscillator) 09:14:22 INFO - PROCESS | 29026 | RSS: Main: 173334528 09:14:22 INFO - PROCESS | 29026 | 09:14:24 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60869/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:24 INFO - PROCESS | 29026 | RSS: Main: 175337472 09:14:24 INFO - PROCESS | 29026 | 09:14:27 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60869/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:28 INFO - PROCESS | 29026 | RSS: Main: 213815296 09:14:28 INFO - PROCESS | 29026 | 09:14:31 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60869/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:32 INFO - PROCESS | 29026 | RSS: Main: 212983808 09:14:32 INFO - PROCESS | 29026 | 09:14:34 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60869/tests/kraken/driver.html?testName=json-parse-financial) 09:14:35 INFO - PROCESS | 29026 | RSS: Main: 211324928 09:14:35 INFO - PROCESS | 29026 | 09:14:36 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60869/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:37 INFO - PROCESS | 29026 | RSS: Main: 173936640 09:14:37 INFO - PROCESS | 29026 | 09:14:39 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:39 INFO - PROCESS | 29026 | RSS: Main: 180903936 09:14:39 INFO - PROCESS | 29026 | 09:14:41 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:42 INFO - PROCESS | 29026 | RSS: Main: 189919232 09:14:42 INFO - PROCESS | 29026 | 09:14:44 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:45 INFO - PROCESS | 29026 | RSS: Main: 198098944 09:14:45 INFO - PROCESS | 29026 | 09:14:48 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:48 INFO - PROCESS | 29026 | RSS: Main: 194416640 09:14:48 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | Cycle 1(1): loaded http://localhost:60869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60869/tests/kraken/driver.html?testName=ai-astar) 09:14:50 INFO - PROCESS | 29026 | RSS: Main: 245997568 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | __start_tp_report 09:14:50 INFO - PROCESS | 29026 | _x_x_mozilla_page_load 09:14:50 INFO - PROCESS | 29026 | _x_x_mozilla_page_load_details 09:14:50 INFO - PROCESS | 29026 | |i|pagename|runs| 09:14:50 INFO - PROCESS | 29026 | |0;ai-astar;102;114;112;111;114;113;112;114;113;111 09:14:50 INFO - PROCESS | 29026 | |1;audio-beat-detection;148;118;118;155;117;118;118;119;147;117 09:14:50 INFO - PROCESS | 29026 | |2;audio-dft;160;160;162;161;159;160;160;161;161;159 09:14:50 INFO - PROCESS | 29026 | |3;audio-fft;75;76;76;109;76;76;74;76;106;76 09:14:50 INFO - PROCESS | 29026 | |4;audio-oscillator;81;82;109;82;82;81;107;81;81;110 09:14:50 INFO - PROCESS | 29026 | |5;imaging-gaussian-blur;117;117;117;118;117;117;118;116;118;117 09:14:50 INFO - PROCESS | 29026 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;145;145 09:14:50 INFO - PROCESS | 29026 | |7;imaging-desaturate;85;86;84;84;85;84;84;84;85;84 09:14:50 INFO - PROCESS | 29026 | |8;json-parse-financial;49;48;48;49;49;48;51;51;50;49 09:14:50 INFO - PROCESS | 29026 | |9;json-stringify-tinderbox;65;59;59;59;60;59;59;59;59;60 09:14:50 INFO - PROCESS | 29026 | |10;stanford-crypto-aes;74;75;75;74;80;80;74;74;76;74 09:14:50 INFO - PROCESS | 29026 | |11;stanford-crypto-ccm;125;121;131;129;127;124;122;120;161;121 09:14:50 INFO - PROCESS | 29026 | |12;stanford-crypto-pbkdf2;158;162;156;163;155;155;157;155;155;155 09:14:50 INFO - PROCESS | 29026 | |13;stanford-crypto-sha256-iterative;62;62;63;75;62;63;63;62;62;61 09:14:50 INFO - PROCESS | 29026 | __end_tp_report 09:14:50 INFO - PROCESS | 29026 | __start_cc_report 09:14:50 INFO - PROCESS | 29026 | _x_x_mozilla_cycle_collect,1599 09:14:50 INFO - PROCESS | 29026 | __end_cc_report 09:14:50 INFO - PROCESS | 29026 | __startTimestamp1484759690760__endTimestamp 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | ------- Summary: start ------- 09:14:50 INFO - PROCESS | 29026 | Number of tests: 14 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.57 (3.2%) stddev-sans-first:1.22 09:14:50 INFO - PROCESS | 29026 | Values: 102.0 114.0 112.0 111.0 114.0 113.0 112.0 114.0 113.0 111.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:118.50 stddev:15.67 (13.2%) stddev-sans-first:14.76 09:14:50 INFO - PROCESS | 29026 | Values: 148.0 118.0 118.0 155.0 117.0 118.0 118.0 119.0 147.0 117.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 09:14:50 INFO - PROCESS | 29026 | Values: 160.0 160.0 162.0 161.0 159.0 160.0 160.0 161.0 161.0 159.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.47 (17.7%) stddev-sans-first:14.05 09:14:50 INFO - PROCESS | 29026 | Values: 75.0 76.0 76.0 109.0 76.0 76.0 74.0 76.0 106.0 76.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.00 stddev:13.18 (16.3%) stddev-sans-first:13.61 09:14:50 INFO - PROCESS | 29026 | Values: 81.0 82.0 109.0 82.0 82.0 81.0 107.0 81.0 81.0 110.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:14:50 INFO - PROCESS | 29026 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 118.0 116.0 118.0 117.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:14:50 INFO - PROCESS | 29026 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:14:50 INFO - PROCESS | 29026 | Values: 85.0 86.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#8] json-parse-financial Cycles:10 Average:49.20 Median:49.00 stddev:1.14 (2.3%) stddev-sans-first:1.20 09:14:50 INFO - PROCESS | 29026 | Values: 49.0 48.0 48.0 49.0 49.0 48.0 51.0 51.0 50.0 49.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:1.87 (3.2%) stddev-sans-first:0.44 09:14:50 INFO - PROCESS | 29026 | Values: 65.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 60.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:2.41 (3.2%) stddev-sans-first:2.49 09:14:50 INFO - PROCESS | 29026 | Values: 74.0 75.0 75.0 74.0 80.0 80.0 74.0 74.0 76.0 74.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:12.12 (9.6%) stddev-sans-first:12.81 09:14:50 INFO - PROCESS | 29026 | Values: 125.0 121.0 131.0 129.0 127.0 124.0 122.0 120.0 161.0 121.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.10 Median:156.50 stddev:3.03 (1.9%) stddev-sans-first:3.20 09:14:50 INFO - PROCESS | 29026 | Values: 158.0 162.0 156.0 163.0 155.0 155.0 157.0 155.0 155.0 155.0 09:14:50 INFO - PROCESS | 29026 | 09:14:50 INFO - PROCESS | 29026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:62.50 stddev:4.09 (6.5%) stddev-sans-first:4.30 09:14:50 INFO - PROCESS | 29026 | Values: 62.0 62.0 63.0 75.0 62.0 63.0 63.0 62.0 62.0 61.0 09:14:50 INFO - PROCESS | 29026 | -------- Summary: end -------- 09:14:50 INFO - PROCESS | 29026 | 09:14:51 INFO - TEST-INFO | 29026: exit 0 09:14:51 INFO - TEST-OK | kraken | took 59797ms 09:14:51 INFO - SUITE-END | took 1175s 09:14:52 INFO - Completed test suite (00:19:35) 09:14:52 INFO - javascript benchmark 09:14:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3174.5555622212887, 3207.4868021116617, 3209.5667084943525, 3224.532442795795, 3260.75544334175, 5495.6153069285165, 5605.411431799658, 5622.803201887929, 5624.465675760796, 5630.5495560355175, 5594.076977298751, 5652.689102099383, 5658.43415658434, 5661.745221465034, 5687.289088863892, 5088.4911508849, 5106.183010718286, 5138.66598671087, 5160.716160611165, 5188.948110518903, 4940.530649588283, 4947.9505204947845, 5180.559652429529, 5203.0, 5204.0372531081875, 5094.133997220481, 5115.897682046376, 5132.692038477685, 5140.228965655163, 5152.845414637567, 5158.071547121516, 5169.948300516984, 5233.5551478124025, 5240.266362709223, 5251.396089449686, 4946.1344264753525, 4947.431045429786, 5150.613703972217, 5171.7672704728375, 5222.63441559091, 5473.425290344497, 5512.062949298629, 5521.089020311644, 5526.419725928759, 5537.861553461155, 5965.13505541694, 5997.130416089686, 6014.669193194372, 6014.879702405928, 6017.819465416001, 5850.23946886902, 5888.735006924699, 6076.605020673642, 6093.847653808646, 6100.664463454508, 5620.662760234358, 5643.887122257573, 5667.8583035424035, 5713.371529131792, 5714.628549144292, 6242.531810114168, 6261.843453913689, 6262.5616206866, 6264.968675156595, 6265.71804268809, 5780.075187969988, 5836.795712150054, 6008.939910600925, 6015.0977353396465, 6024.096385542204, 5912.704364781744, 5954.374790647006, 5964.403559644001, 6000.5799594028, 6037.577369584087, 5946.345901950782, 5960.225170727777, 5964.254468191476, 5967.254093238345, 5973.342932277446, 5727.255456790674, 5948.345681974979, 5987.850303742354, 5989.041753319448, 5990.161377407167, 4491.146682130385, 4527.230370836965, 4581.335706322565, 4585.358049873021, 4638.976805115953, 4080.9795951020055, 4094.324436468009, 4098.713090083726, 4116.197341518375, 4120.196561670506, 5707.315122185364, 5714.399988001283, 5715.914261286084, 5716.885662286731, 5744.109663002241, 5789.160571717078, 5856.765729370863, 5947.6431414115295, 5950.642961422329, 5994.580379373489, 5710.7430165642645, 5717.313922329347, 5717.456841600041, 5718.0, 5738.110592858114, 5171.81898633546, 5174.146265866165, 5177.223416487557, 5177.896442071137, 5221.347331583552, 6042.788502402483, 6113.871604717359, 6115.082737589397, 6233.470155036873, 6279.089532017923, 6020.217371741645, 6057.818265451867, 6059.0, 6079.422454866781, 6088.817335479943, 6270.592411493239, 6274.0, 6274.592151510137, 6276.089966954857, 6290.402411770874, 5638.887222255614, 5744.310682718101, 5955.642661440327, 5965.194698715618, 5995.970020149872, 5909.143174239625, 6019.849503762441, 6032.819015429544, 6095.207623008981, 6134.447899689049, 5894.528437725057, 5934.080217566284, 5967.31375891778, 5969.04495280753, 5974.880502390015, 5562.833115006556, 5942.108683697307, 5948.40515948419, 5948.583599148191, 5949.762009519571, 5645.379008309001, 5825.737841797214, 5881.088431293157, 5890.734916928663, 5942.316633587193, 5930.318013428338, 5964.045752679551, 5966.015607424726, 5968.22413086296, 5973.701314934323, 5587.245721827501, 5641.097424412074, 5648.915266270927, 5699.971500142473, 5805.071188609971], "value": 5539.690738356944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.0641819879094, 601.2484394506866, 621.8165641135864, 645.6868418816873, 663.4824836627432, 34100.14749631257, 36996.260074798556, 37088.07279818006, 37153.81423092884, 37466.25067498652, 37579.62420375796, 47085.293720594134, 47783.52216477834, 47914.76042619782, 51946.22080668793, 8817.11828817118, 8940.329475289347, 8953.597088131017, 8959.686410975617, 8960.551972401387, 8322.625481853302, 8486.53324067176, 8909.73270801877, 8999.23506501948, 9001.729948101567, 10550.525226364833, 10863.565457381696, 10867.456627168649, 11197.832032519518, 11205.21563490556, 10528.78942421151, 10584.206184536191, 10599.311044782064, 10606.204534659932, 10607.045365917027, 10628.256022078458, 10691.358518488838, 10705.946470267676, 10711.0, 10716.946415267874, 43944.3408348875, 43975.78012109951, 44140.3378949316, 44387.0, 44426.55573444256, 3703.0742314421395, 3727.329080765461, 3731.794751288678, 3757.6618104370737, 3780.3006443807985, 32842.01473955785, 32901.3419731604, 33126.17184570381, 33408.33183336344, 33984.6601533984, 4429.357743127229, 4488.842890498817, 4517.683762136652, 4522.886927826798, 4580.038191979688, 359141.0, 368390.0, 368577.0, 490323.0, 496578.0, 61447.69276153591, 61555.07667384993, 61783.69108154521, 61845.69077154585, 61889.690551546955, 40102.0, 66660.0, 66702.33297667059, 66825.0, 66933.33066669368, 17356.218970146372, 17434.651306974043, 17441.912790435967, 17451.91274043647, 17482.125893705263, 14046.929765351108, 14135.78796318056, 14170.645733856736, 14170.645733856736, 14171.503997360249, 18245.7263141053, 18272.908635456737, 20004.099815508336, 20163.99180040992, 20365.59268814645, 7154.027950574301, 7193.424526037905, 7232.168300645388, 7246.384057355079, 7524.291255148142, 980.3872579637726, 1015.619142821442, 1027.3322340478749, 1029.3926583315729, 1105.27604419104, 32783.1804204892, 33412.1646958828, 33553.328933421195, 33604.159896002304, 34102.65897341044, 1036.3212096077082, 1114.1365441782684, 1125.7129431994788, 1136.7158210447387, 1180.3729380827008, 15183.0, 16210.75683864743, 16411.0, 16823.747643785355, 17548.2103305349, 530606.0, 530815.0, 531444.0, 532321.0, 532690.0, 55574.0, 56676.0, 60373.69813150994, 61406.0, 61419.38580614136, 1369.459063669845, 1393.2406838273166, 1397.7693680543002, 1400.9649758755909, 1408.9013769036274, 31999.680003200603, 34629.30741385208, 34734.13164670904, 34745.478817817246, 34772.38534578155, 55073.0, 55415.44584554103, 55581.44418555763, 55598.44401556095, 55635.0, 429480.0, 430577.0, 432106.0, 432954.0, 434126.0, 30875.69124308728, 30904.0, 31056.534151987285, 31161.37677246488, 31436.0, 50208.74895625498, 50454.747726261136, 50617.24074138964, 50644.49355506398, 51478.0, 41421.378679320434, 41739.0, 42857.35713964231, 44163.55836441723, 45039.0, 41211.0, 41335.37996930109, 41669.58330416657, 42464.57535424606, 42952.57047429486, 41880.58119418767, 42548.78725606352, 42731.14537709291, 43193.3520997179, 43418.56581434271, 31072.53391199179, 32757.344853102328, 34407.31185376328, 34422.48366274458, 34499.310013799084, 25606.48787024212, 26297.0, 26311.605325919743, 26418.867905660347, 26496.56037512317], "value": 20906.612730734523, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.2273836434678, 408.65468678966283, 420.31278859065424, 424.4100700026962, 426.31150691633, 14675.559733207994, 16604.169791510423, 19493.220271189137, 19856.99999999998, 20690.68963965538, 19169.233230670758, 19499.512512187168, 19655.115519801606, 20026.49933751657, 20233.49416264594, 5629.380768115504, 5665.3078289955065, 5720.170575266584, 5825.621334613258, 5839.737211825457, 4384.386185933972, 4509.594136527712, 5702.543796496291, 5783.450572195635, 5795.4784069433745, 4526.049529598772, 4535.206338890697, 6160.815175544741, 6403.359664033606, 6415.839604009914, 5547.916781248305, 5760.279965004374, 5796.50729687977, 6495.837604059889, 6531.248906375757, 5612.242347283105, 5660.377358490604, 5663.348714897798, 5663.490285874291, 5665.801696940587, 13631.386587603582, 13683.521076762365, 13918.860811391958, 13943.511977080854, 13950.372233249427, 2317.4901521665374, 2386.2721869829693, 2463.1379017343966, 2526.621006848969, 2806.663200415943, 10098.646547370807, 10202.489875506195, 10431.582736690523, 10501.474926253657, 11013.118950483942, 1920.875143115693, 2010.095457044336, 2010.2763005318075, 2037.4397040813747, 2047.8873661948735, 80695.0, 83576.0, 84361.0, 85561.0, 90513.0, 9352.812943741086, 9761.560729767178, 9780.23955687983, 9811.430171172578, 9818.90181098194, 13021.218726876228, 13116.934415327862, 13132.671683207996, 13137.080404371602, 13139.145955513051, 7853.0, 7966.322862556632, 8003.799905002422, 8191.79520511992, 8216.301614362726, 8337.166283371615, 8342.332613390914, 8458.746237612759, 8535.615897284637, 8560.0, 3842.654161125512, 3994.1412596291357, 4019.2765302245875, 4030.5969403059457, 4262.50981137167, 1840.438666206793, 1844.2807305151002, 1890.4234208566245, 1891.3191251149576, 1894.981050189508, 932.2169377722745, 956.4404823178379, 958.4584709639032, 996.1582462818907, 1033.0857191385528, 18988.81011189898, 19032.71450928237, 19586.31447899317, 19903.900480497505, 20839.479013024797, 953.2032119454739, 966.2559828931824, 986.3095832916987, 990.945497997617, 994.5773046455228, 10227.590896364061, 10803.567857285621, 11013.063889569476, 11125.44372781374, 11129.0, 444584.0, 449227.0, 449736.0, 456182.0, 458302.0, 56319.71840140855, 88293.55853220822, 91293.0, 94769.5261523688, 99415.50292248493, 992.0525897767615, 1019.0675531888387, 1023.8720159980003, 1031.200819364998, 1036.1141224253156, 17194.0, 17350.826491734922, 17438.651226975137, 17447.651046978735, 17865.374711885022, 42010.0, 42465.0, 42520.57479425166, 43503.12993740171, 45009.549904500534, 54938.725306374814, 58961.0, 59762.0, 59890.0, 60987.695061524406, 6518.282988871315, 7942.0, 8226.794330141794, 8402.453840500348, 8498.235158835734, 12239.553513195913, 12243.265404075428, 12993.740125197632, 13072.084954053125, 13086.672833178865, 11050.33697978124, 11052.613158539412, 11093.278936869077, 11401.600943966921, 11736.237144585575, 11140.665780026613, 11262.605808796652, 11387.373694446553, 11398.772024559297, 11408.657740267805, 10718.08896243828, 11081.944590276997, 11154.776904462027, 11154.944225279147, 11495.827562586735, 8131.634076466455, 8186.140455252351, 8265.628046737791, 8350.958245208734, 8661.696840610548, 8562.52906090171, 10582.0, 10970.945145274223, 11086.22396432242, 11360.488778004845], "value": 8906.143460163132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.1678018018922, 1461.298576683192, 1477.7266205751937, 1640.3520609359302, 1796.470041337806, 6918.446524278058, 7440.255974402557, 7880.448368614199, 7883.329916957051, 7893.763187104381, 7721.961390193042, 7857.0, 7859.842803143933, 8072.55600941948, 8073.0, 2297.1041293895396, 2327.162221600231, 2327.767223277676, 2327.8137748980125, 2335.4861930375373, 2331.63859601762, 2382.4282172278704, 2400.6879105716234, 2404.5791986402396, 2405.6271277951946, 2307.1002309099463, 2320.245920075982, 2333.8599684018927, 2336.7663233676667, 2342.0163531316803, 2291.8281128915232, 2297.8161747060194, 2319.3042087373806, 2320.501092265154, 2332.428555004018, 2298.5288015956858, 2315.9421014474774, 2317.617593097137, 2319.3621754017613, 2320.501092265171, 7741.419393545507, 7820.765377038698, 7921.603919803987, 7968.04383473981, 7971.72098976533, 4861.538153875376, 4989.426215985136, 5002.499750025005, 5007.37407824022, 5009.348784658007, 3273.7544684148784, 3330.4837750148768, 3348.4049861357644, 3351.379994700988, 3377.189474526096, 1034.865467489229, 1047.2721458586286, 1062.6493257225097, 1086.0876863434753, 1099.274478843959, 10584.576616935314, 10752.73118172044, 10819.350838949687, 10891.128709703284, 10896.891031089666, 4192.895177620523, 4314.805833737427, 4328.372386004012, 4399.758013309299, 4404.7357158570585, 9302.488363140092, 9313.068693130634, 9317.16145546904, 9322.487263200454, 9324.487153206503, 5000.649954503223, 5024.572911302507, 5041.319421878, 5042.369703787027, 5046.167382381939, 4135.648469880034, 4222.387753775747, 4260.68044896634, 4577.404937358122, 4600.884977875513, 3882.0, 3934.5278566571624, 3985.780782056957, 4007.6192761688176, 4031.677465802729, 1229.170310040737, 1234.2964510229083, 1240.1133189769357, 1248.3383806582526, 1252.6868282929267, 920.5673333533229, 928.8467402878449, 943.2454036770556, 953.774399896144, 980.4068538534227, 5196.8960620787375, 5397.811076612378, 5429.701366424805, 5570.303712035996, 5622.718864056781, 401.8272142978547, 403.8303912356817, 404.953430355507, 411.1263564924535, 414.87968489138416, 3744.5693745219105, 3952.130531283113, 3955.723099383073, 3958.9208215835524, 4074.246264441088, 9319.347645664739, 9471.384360016715, 9644.18024467928, 9709.0, 9711.36876103051, 9465.668701595549, 9627.0, 9660.613575457044, 9665.613375464902, 9665.90334096664, 7557.811054723566, 7742.922570774333, 7743.186965368555, 7745.186755390716, 7746.922530774733, 5509.889802204014, 5517.117261238182, 5540.667559946416, 5649.039663257174, 5654.575906807088, 8863.734087977371, 8900.243479304332, 9011.864822027806, 9024.0, 9024.278057755233, 9090.272778177598, 9182.632694692405, 9188.862167067366, 9195.724128276162, 9201.953990230273, 6597.27429982692, 6767.221769496374, 6933.653317334214, 7255.709771609077, 7337.119545654556, 7631.3894888407685, 7906.9209307906185, 7909.960450197712, 7912.643931023003, 7913.366930645419, 6867.725290988505, 6908.067410899464, 6967.303269673195, 6971.616561088986, 7014.158301003912, 6527.412532871875, 6644.933550664625, 7047.682854271673, 7157.606331651809, 7199.1361036675935, 6100.26796784371, 6233.314335423191, 6300.9684951574945, 6307.842303942438, 6400.647964361819, 4560.247559152703, 4567.588916997486, 4891.90216195667, 4958.776855041604, 4988.625853061108, 4993.126202914403, 5046.545810877039, 5103.795848166032, 5143.974280128576, 5164.32863727713], "value": 4260.216840882913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.54549993758565, 331.5077110490921, 333.2119537294298, 337.21597286309327, 344.9275652113056, 5106.136260265004, 5172.0, 5281.788728450862, 5293.788248470061, 5293.814716484924, 5062.898742025157, 5157.458466860982, 5180.507851754077, 5199.376074871021, 5206.802435439851, 4115.855945041924, 4128.318827393491, 4131.400946862711, 4135.234981528427, 4180.665546756252, 3935.8425662973445, 4092.5907409259135, 4163.854265100722, 4169.166166766644, 4174.0, 4055.3105971984687, 4064.248114098886, 4072.2669919414493, 4073.775942323171, 4076.164386300816, 4063.6952228582827, 4069.232921613287, 4075.3886916962397, 4103.138340948404, 4113.9794301028605, 3480.955713286004, 3571.94642080369, 3575.5173051638217, 3579.785212887235, 3620.945685814715, 5020.924686129711, 5042.747862606891, 5070.543651071422, 5081.491850814926, 5094.5160209780015, 4560.973780899304, 4590.60979816716, 4602.148602508513, 4606.7887414041115, 4614.007988282502, 5181.715005674687, 5394.91907621386, 5399.352077750656, 5419.566434685215, 5464.0, 3936.893761837432, 3943.585923478051, 3943.861964831246, 3957.0, 3962.425448309979, 5681.460261275172, 5701.401352857932, 5702.885942281173, 5706.146926536731, 5747.511461525817, 3922.5685174630767, 4021.658159056513, 4048.372502262095, 4069.3895915612893, 4071.572484889103, 4055.7972101395403, 4064.166845796605, 4064.288749468831, 4076.7146299758733, 4079.918401631951, 4598.609118224921, 4602.930956035662, 4604.40142781443, 4630.629549636021, 4638.234691275969, 5314.1497360422145, 5423.349198096174, 5447.237386765856, 5472.863178420572, 5483.683915860165, 1345.5156143788229, 1348.1371921969946, 1351.9589915764807, 1353.4518519999417, 1365.6381059019368, 917.312015988009, 933.3466573398648, 948.6347756113807, 954.9877130241965, 959.0649117110761, 5021.899562008813, 5038.722870242172, 5039.538533825223, 5041.974790126026, 5053.393592768891, 5233.973830130825, 5249.317588713443, 5265.3944796348915, 5330.466953304638, 5367.651102678392, 4833.419989601271, 5044.0, 5066.60668316216, 5070.29015937769, 5102.668326558762, 2808.5365914624267, 2846.0892514395196, 2857.8856845726355, 2890.8699108539745, 2896.029830006929, 5578.693171875505, 5587.8882422352135, 5615.326160860723, 5635.21107045014, 5649.209110724501, 5244.711540865213, 5410.3507579090765, 5421.457854214547, 5464.295173888951, 5541.4811594637695, 5512.80705175317, 5522.861928451821, 5523.392426833045, 5561.277033985637, 5566.133441277745, 5188.221766734869, 5350.866228344167, 5384.4346343634925, 5390.757415916215, 5400.9459905400445, 5302.310699609026, 5306.461126273492, 5329.520343169133, 5342.225377320189, 5354.732263386737, 5540.418256083053, 5550.500454958911, 5558.916616250679, 5569.860753481195, 5602.579806514609, 3864.46877295372, 3919.529656441245, 3947.921041579095, 3950.2889479893897, 3984.8206830693266, 5531.170324451365, 5567.164925261081, 5572.3034620672415, 5588.888222235614, 5591.776328946797, 5481.150421684645, 5481.424450432647, 5488.286522752017, 5495.560355171657, 5499.862503437446, 5251.396089449762, 5404.54061404785, 5420.457954204706, 5420.810271640474, 5427.83716488506, 5395.487428694268, 5397.139516056496, 5447.155690867922, 5469.9179512306555, 5474.753636086306, 5345.866353341197, 5448.863778405572, 5508.20131080983, 5522.061249587499, 5528.751206195811, 5275.525202731619, 5306.363236411656, 5326.493983071602, 5333.013392522395, 5336.973315133399], "value": 4123.387692586455, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.3271105072009, 788.9250521200488, 799.2886331165261, 846.8433339832134, 850.9659613615456, 15590.0, 15886.523404297875, 16249.268782904754, 16584.419545315915, 16734.58163545912, 15396.84603153968, 15728.134952577604, 16401.343946242137, 16563.0, 16571.50285491437, 842.7134774176794, 850.6980022092162, 852.382023033299, 852.526847599582, 853.7865533616596, 723.5369363607296, 730.426615107141, 845.602566793606, 862.3877047296427, 866.7096522664883, 909.4225167018924, 911.3483859040784, 912.0788004115858, 912.4114945859916, 912.4570880326195, 898.2723993565168, 903.1510380242617, 907.0566610724871, 907.5598334807613, 907.9909200908005, 548.7859734703469, 561.2255087978564, 648.6626953983949, 649.0556240669814, 658.1904257762978, 14451.349689264009, 14574.344154513072, 14611.48859789913, 14630.268486575735, 14633.048851824597, 13395.531156409575, 13535.18788872661, 13571.117877337942, 13586.59240222785, 13659.658508537266, 13075.542356017493, 13184.40670169835, 13198.73602527944, 13258.40337184829, 13271.668208294774, 4439.578240067189, 4454.910901781946, 4459.130469558438, 4468.597826195625, 4583.9541604583865, 57441.425585744444, 58864.411355886325, 59561.702191489196, 66410.0, 66804.6659766698, 11683.0, 11761.0, 11829.585964491202, 11893.940530297294, 12199.085068619888, 20620.69068963967, 20686.896565517378, 20701.0, 20722.896385518277, 20741.066652000696, 8801.0, 8850.73447796567, 9022.14289642483, 9081.45511269326, 9251.861222081674, 4851.151048566487, 4877.707337559757, 4933.55597996182, 4986.102501549683, 5086.491350864958, 3440.0, 3575.5530558680166, 3575.910602234913, 3577.7853328799833, 3594.227241143167, 646.1051443750439, 659.5053709717712, 660.1451120798578, 666.5534092158266, 675.2268652392983, 644.5294934697697, 652.360686527206, 658.9868202636017, 728.9161746399126, 751.5678484871221, 9406.764830879283, 9537.427754334762, 9667.27495437845, 9875.0, 10323.94838025805, 677.664556044761, 704.4188544450849, 731.2102928836844, 739.183202561173, 748.468587303021, 4469.217886869785, 4595.701279416827, 4628.675992680547, 4680.160815221764, 4842.0, 68547.65726171437, 93454.53272733728, 95846.52076739712, 96052.0, 99424.50287748515, 67580.66209668921, 68781.65609171923, 81590.0, 82659.0, 85064.0, 58882.41117588769, 66405.33594663991, 66933.33066669271, 68359.0, 70946.64526677334, 8884.822303554021, 9153.313501487548, 9944.701658950244, 10142.797144057226, 10289.794204115726, 34863.47704784379, 41240.587594124874, 47453.52546474491, 47743.522564773906, 48188.75905620449, 39187.216255675296, 44597.55402445934, 62711.0, 63041.36958630355, 65941.04353738792, 12054.939725301318, 12188.57339993096, 12344.4444999977, 12537.749245014866, 12570.748585028432, 14420.927895360455, 14725.337359819048, 14770.704585908437, 14963.476278330207, 15231.314590843216, 13434.731305374033, 13572.321383930961, 14391.0, 14446.133232006114, 14674.33965471535, 13415.195088294733, 13668.794968075288, 13815.171089734647, 13961.650958726113, 14046.859531404963, 12899.613011609667, 12977.740445190855, 13092.738145236852, 13159.934200328937, 13299.26854023038, 10412.32319899204, 10865.565377384815, 11050.0, 11106.444677765918, 11248.606298779503, 9688.321817472992, 10685.145188385066, 10695.197860160675, 10716.57133714674, 10853.511591978538], "value": 7381.78275718355, "unit": "score"}], "name": "dromaeo_css", "value": 7151.42537200144, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 112.0, 111.0, 114.0, 113.0, 112.0, 114.0, 113.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 118.0, 118.0, 155.0, 117.0, 118.0, 118.0, 119.0, 147.0, 117.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 159.0], "value": 160.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 109.0, 76.0, 76.0, 74.0, 76.0, 106.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 109.0, 82.0, 82.0, 81.0, 107.0, 81.0, 81.0, 110.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 49.0, 49.0, 48.0, 51.0, 51.0, 50.0, 49.0], "value": 49.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 74.0, 80.0, 80.0, 74.0, 74.0, 76.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 121.0, 131.0, 129.0, 127.0, 124.0, 122.0, 120.0, 161.0, 121.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 156.0, 163.0, 155.0, 155.0, 157.0, 155.0, 155.0, 155.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 75.0, 62.0, 63.0, 63.0, 62.0, 62.0, 61.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1451.6999999999998, "alertThreshold": 2.0}]} 09:14:52 INFO - Return code: 0 09:14:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:52 INFO - # TBPL SUCCESS # 09:14:52 INFO - Running post-action listener: _resource_record_post_action 09:14:52 INFO - [mozharness: 2017-01-18 17:14:52.549509Z] Finished run-tests step (success) 09:14:52 INFO - Running post-run listener: _resource_record_post_run 09:14:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357044224; Read time: 28; Write time: 226668 09:14:52 INFO - TinderboxPrint: CPU usage
13.0% 09:14:52 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 09:14:52 INFO - TinderboxPrint: I/O write bytes / time
357,044,224 / 226,668 09:14:52 INFO - TinderboxPrint: CPU idle
8,278.5 (87.0%) 09:14:52 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 09:14:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:14:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107728896; Read time: 0; Write time: 69952 09:14:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248164352; Read time: 16; Write time: 156680 09:14:53 INFO - Running post-run listener: _upload_blobber_files 09:14:53 INFO - Blob upload gear active. 09:14:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:14:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:54 INFO - (blobuploader) - INFO - Done attempting. 09:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:55 INFO - (blobuploader) - INFO - Done attempting. 09:14:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:58 INFO - (blobuploader) - INFO - Done attempting. 09:14:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:58 INFO - Return code: 0 09:14:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b5dd5a2e4ced3e4e5f550ada35eebc13a5fe796455540456691a8fe9842702d25635cead41ebe51058436050ec0c2d8a7ffe00140a2c05f69fadb855230366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbf80f0c494282d5eea970337e23bbf45d63686390cf0c639ad39f1640fe05b4f6091c97cf5fe3747e1ff9676da1ba2d1bf918436b092a6107c535e1d7031d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9250021c2408f71e05c35ad66656ac259726d30bb4957e7f659c8f44cc3b33a7b9ab799bc8e14c18aa3f2665f9e26171c519499ed8bea6f935746a73682bee09"} 09:14:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:58 INFO - Contents: 09:14:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b5dd5a2e4ced3e4e5f550ada35eebc13a5fe796455540456691a8fe9842702d25635cead41ebe51058436050ec0c2d8a7ffe00140a2c05f69fadb855230366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbf80f0c494282d5eea970337e23bbf45d63686390cf0c639ad39f1640fe05b4f6091c97cf5fe3747e1ff9676da1ba2d1bf918436b092a6107c535e1d7031d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9250021c2408f71e05c35ad66656ac259726d30bb4957e7f659c8f44cc3b33a7b9ab799bc8e14c18aa3f2665f9e26171c519499ed8bea6f935746a73682bee09"} 09:14:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:58 INFO - Copying logs to upload dir... 09:14:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.692511 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-18 09:14:57.794344) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 09:14:57.798996) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b5dd5a2e4ced3e4e5f550ada35eebc13a5fe796455540456691a8fe9842702d25635cead41ebe51058436050ec0c2d8a7ffe00140a2c05f69fadb855230366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbf80f0c494282d5eea970337e23bbf45d63686390cf0c639ad39f1640fe05b4f6091c97cf5fe3747e1ff9676da1ba2d1bf918436b092a6107c535e1d7031d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9250021c2408f71e05c35ad66656ac259726d30bb4957e7f659c8f44cc3b33a7b9ab799bc8e14c18aa3f2665f9e26171c519499ed8bea6f935746a73682bee09"} build_url:https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011344 build_url: 'https://queue.taskcluster.net/v1/task/X37gorV_RyaWhbNqJz9Jcw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/07b5dd5a2e4ced3e4e5f550ada35eebc13a5fe796455540456691a8fe9842702d25635cead41ebe51058436050ec0c2d8a7ffe00140a2c05f69fadb855230366", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbf80f0c494282d5eea970337e23bbf45d63686390cf0c639ad39f1640fe05b4f6091c97cf5fe3747e1ff9676da1ba2d1bf918436b092a6107c535e1d7031d57", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9250021c2408f71e05c35ad66656ac259726d30bb4957e7f659c8f44cc3b33a7b9ab799bc8e14c18aa3f2665f9e26171c519499ed8bea6f935746a73682bee09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 09:14:57.823594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:14:57.826935) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d6bbd613908ccac0c6c9cb47000001f7-1484758460.671539-418689493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 09:14:57.907282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 09:14:57.907588) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 09:14:57.910892) ========= ========= Total master_lag: 0.17 =========