builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1485911559.09 results: success (0) buildid: 20170131151409 builduid: e6f30b2277eb48038f3141a8217db3ad revision: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.085727) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.086221) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.086496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.102911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.103259) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-31 17:12:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-01-31 17:12:39 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151352 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.270627) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.271070) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019883 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:39.321532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 17:12:39.321927) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 --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-beta --rev c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 --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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-31 17:12:39,951 truncating revision to first 12 chars 2017-01-31 17:12:39,951 Setting DEBUG logging. 2017-01-31 17:12:39,951 attempt 1/10 2017-01-31 17:12:39,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c16a0fc964a5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 17:12:41,282 unpacking tar archive at: mozilla-beta-c16a0fc964a5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.627709 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-31 17:12:40.962658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:40.962975) ========= script_repo_revision: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:40.963357) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:40.963691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:12:40.971169) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-31 17:12:40.971462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:12:41 INFO - MultiFileLogger online at 20170131 17:12:41 in /builds/slave/test 17:12:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 17:12:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:12:41 INFO - {'append_to_log': False, 17:12:41 INFO - 'base_work_dir': '/builds/slave/test', 17:12:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:12:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:12:41 INFO - 'branch': 'Mozilla-Beta', 17:12:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:12:41 INFO - 'config_files': ('talos/linux_config.py',), 17:12:41 INFO - 'default_actions': ('clobber', 17:12:41 INFO - 'read-buildbot-config', 17:12:41 INFO - 'download-and-extract', 17:12:41 INFO - 'populate-webroot', 17:12:41 INFO - 'create-virtualenv', 17:12:41 INFO - 'install', 17:12:41 INFO - 'run-tests'), 17:12:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:12:41 INFO - 'download_minidump_stackwalk': True, 17:12:41 INFO - 'download_symbols': 'ondemand', 17:12:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:12:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:12:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:12:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:12:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:12:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:12:41 INFO - 'installer_path': 'installer.exe', 17:12:41 INFO - 'log_level': 'info', 17:12:41 INFO - 'log_name': 'talos', 17:12:41 INFO - 'log_to_console': True, 17:12:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:12:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:12:41 INFO - 'opt_config_files': (), 17:12:41 INFO - 'pip_index': False, 17:12:41 INFO - 'sps_profile': False, 17:12:41 INFO - 'sps_profile_interval': 0, 17:12:41 INFO - 'suite': 'dromaeojs', 17:12:41 INFO - 'system_bits': '32', 17:12:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:12:41 INFO - 'title': 'talos-linux64-ix-061', 17:12:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:12:41 INFO - 'use_talos_json': True, 17:12:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:12:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:12:41 INFO - 'work_dir': 'build'} 17:12:41 INFO - [mozharness: 2017-02-01 01:12:41.696531Z] Running clobber step. 17:12:41 INFO - Running pre-action listener: _resource_record_pre_action 17:12:41 INFO - Running main action method: clobber 17:12:41 INFO - rmtree: /builds/slave/test/build 17:12:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:12:42 INFO - Running post-action listener: _resource_record_post_action 17:12:42 INFO - [mozharness: 2017-02-01 01:12:42.203863Z] Finished clobber step (success) 17:12:42 INFO - [mozharness: 2017-02-01 01:12:42.203963Z] Running read-buildbot-config step. 17:12:42 INFO - Running pre-action listener: _resource_record_pre_action 17:12:42 INFO - Running main action method: read_buildbot_config 17:12:42 INFO - Using buildbot properties: 17:12:42 INFO - { 17:12:42 INFO - "project": "", 17:12:42 INFO - "product": "firefox", 17:12:42 INFO - "script_repo_revision": "production", 17:12:42 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 17:12:42 INFO - "repository": "", 17:12:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 17:12:42 INFO - "buildid": "20170131151409", 17:12:42 INFO - "pgo_build": "True", 17:12:42 INFO - "basedir": "/builds/slave/test", 17:12:42 INFO - "buildnumber": 118, 17:12:42 INFO - "slavename": "talos-linux64-ix-061", 17:12:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:12:42 INFO - "platform": "ubuntu64_hw", 17:12:42 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:12:42 INFO - "branch": "mozilla-beta", 17:12:42 INFO - "repo_path": "releases/mozilla-beta", 17:12:42 INFO - "revision": "c16a0fc964a5790de244fc3ea3bb5c3d3c18d071", 17:12:42 INFO - "stage_platform": "linux64-pgo", 17:12:42 INFO - "builduid": "e6f30b2277eb48038f3141a8217db3ad", 17:12:42 INFO - "slavebuilddir": "test" 17:12:42 INFO - } 17:12:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 17:12:42 INFO - Running post-action listener: _resource_record_post_action 17:12:42 INFO - [mozharness: 2017-02-01 01:12:42.206412Z] Finished read-buildbot-config step (success) 17:12:42 INFO - [mozharness: 2017-02-01 01:12:42.206502Z] Running download-and-extract step. 17:12:42 INFO - Running pre-action listener: _resource_record_pre_action 17:12:42 INFO - Running main action method: download_and_extract 17:12:42 INFO - mkdir: /builds/slave/test/build/tests 17:12:42 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')]} 17:12:42 INFO - trying https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 17:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 17:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:12:42 INFO - Downloaded 1327 bytes. 17:12:42 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 17:12:42 INFO - Using the following test package requirements: 17:12:42 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 17:12:42 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:12:42 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 17:12:42 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'jsshell-linux-x86_64.zip'], 17:12:42 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:12:42 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 17:12:42 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 17:12:42 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 17:12:42 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:12:42 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 17:12:42 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:12:42 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:12:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 17:12:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:12:42 INFO - Fetch https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 17:12:43 INFO - Http code: 200 17:12:43 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 17:12:43 INFO - x-amz-cf-id: fiDXiISNUCEhJFwCzIgys83HWld-Jm5SW6GKf6It2zXBdMnPo7by0Q== 17:12:43 INFO - x-amz-version-id: 9_k5DwbCmqgx6C1hJGBjWi5a.mmh_oNX 17:12:43 INFO - Expected file size: 21955267 17:12:43 INFO - Obtained file size: 21955267 17:12:47 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:12:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 17:12:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:12:47 INFO - Fetch https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 17:12:48 INFO - Http code: 200 17:12:48 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 17:12:48 INFO - x-amz-cf-id: 92m6AjsPzejUHKDvDhHiq2lLZDUx6V_k-VS2Xv3TUsBnspISwtnKTQ== 17:12:48 INFO - x-amz-version-id: 9_k5DwbCmqgx6C1hJGBjWi5a.mmh_oNX 17:12:48 INFO - Expected file size: 21955267 17:12:48 INFO - Obtained file size: 21955267 17:12:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 17:12:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:12:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 17:12:53 INFO - Http code: 200 17:12:53 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 17:12:53 INFO - x-amz-cf-id: 7XswsgCbNwHL4SFRIlQHN0KYVZFx6_NUO3czZkie8X4y6R7W0npT9g== 17:12:53 INFO - x-amz-version-id: eUjMqUL3ysZ0G1i0dQZP2j5jggVHDCzP 17:12:53 INFO - Expected file size: 14403005 17:12:53 INFO - Obtained file size: 14403005 17:12:53 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')]} 17:12:53 INFO - trying https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:12:53 INFO - Downloading https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:12:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:12:54 INFO - Downloaded 57705215 bytes. 17:12:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:12:54 INFO - mkdir: /builds/slave/test/properties 17:12:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:12:54 INFO - Writing to file /builds/slave/test/properties/build_url 17:12:54 INFO - Contents: 17:12:54 INFO - build_url:https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 17:12:55 INFO - Running post-action listener: _resource_record_post_action 17:12:55 INFO - Running post-action listener: set_extra_try_arguments 17:12:55 INFO - [mozharness: 2017-02-01 01:12:55.616347Z] Finished download-and-extract step (success) 17:12:55 INFO - [mozharness: 2017-02-01 01:12:55.616577Z] Running populate-webroot step. 17:12:55 INFO - Running pre-action listener: _resource_record_pre_action 17:12:55 INFO - Running main action method: populate_webroot 17:12:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:12:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:12:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:12:55 INFO - '--tppagecycles', 17:12:55 INFO - '7'], 17:12:55 INFO - 'tests': ['tsvgm']}}, 17:12:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:12:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:12:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:12:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:12:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:12:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['damp', 'tps']}, 17:12:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'tests': ['damp', 'tps']}, 17:12:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['dromaeo_dom']}, 17:12:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:12:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['basic_compositor_video']}, 17:12:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:12:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'other-e10s': {'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['a11yr', 17:12:55 INFO - 'ts_paint', 17:12:55 INFO - 'tpaint', 17:12:55 INFO - 'sessionrestore', 17:12:55 INFO - 'sessionrestore_no_auto_restore', 17:12:55 INFO - 'tabpaint']}, 17:12:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['tsvgx', 17:12:55 INFO - 'tsvgr_opacity', 17:12:55 INFO - 'tart', 17:12:55 INFO - 'tscrollx', 17:12:55 INFO - 'cart']}, 17:12:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:12:55 INFO - 'tsvgr_opacity', 17:12:55 INFO - 'tart', 17:12:55 INFO - 'tscrollx', 17:12:55 INFO - 'cart']}, 17:12:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'talos_options': ['--disable-e10s'], 17:12:55 INFO - 'tests': ['tp5o']}, 17:12:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'tests': ['tp5o']}, 17:12:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'talos_options': ['--disable-e10s', 17:12:55 INFO - '--xperf_path', 17:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:55 INFO - 'tests': ['tp5n']}, 17:12:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:12:55 INFO - 'talos_options': ['--xperf_path', 17:12:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:12:55 INFO - 'tests': ['tp5n']}}, 17:12:55 INFO - 'talos.zip': {'path': '', 17:12:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:12:55 INFO - Running post-action listener: _resource_record_post_action 17:12:55 INFO - [mozharness: 2017-02-01 01:12:55.634765Z] Finished populate-webroot step (success) 17:12:55 INFO - [mozharness: 2017-02-01 01:12:55.634853Z] Running create-virtualenv step. 17:12:55 INFO - Running pre-action listener: _resource_record_pre_action 17:12:55 INFO - Running main action method: create_virtualenv 17:12:55 INFO - Creating virtualenv /builds/slave/test/build/venv 17:12:55 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 17:12:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:12:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:12:55 INFO - Using real prefix '/usr' 17:12:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:12:56 INFO - Installing distribute.............................................................................................................................................................................................done. 17:12:58 INFO - Installing pip.................done. 17:12:58 INFO - Return code: 0 17:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:12:58 INFO - Reading from file tmpfile_stdout 17:12:58 INFO - Output received: 17:12:58 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) 17:12:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:12:58 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')]} 17:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:58 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')]} 17:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:58 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:12:58 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 17:12:58 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 17:12:58 INFO - Using env: {'DISPLAY': ':0', 17:12:58 INFO - 'HOME': '/home/cltbld', 17:12:58 INFO - 'LANG': 'en_US.UTF-8', 17:12:58 INFO - 'LANGUAGE': 'en_US:en', 17:12:58 INFO - 'LOGNAME': 'cltbld', 17:12:58 INFO - 'MAIL': '/var/mail/cltbld', 17:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:58 INFO - 'MOZ_NO_REMOTE': '1', 17:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:58 INFO - 'NO_EM_RESTART': '1', 17:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:58 INFO - 'PWD': '/builds/slave/test', 17:12:58 INFO - 'SHELL': '/bin/bash', 17:12:58 INFO - 'SHLVL': '1', 17:12:58 INFO - 'TERM': 'linux', 17:12:58 INFO - 'TMOUT': '86400', 17:12:58 INFO - 'USER': 'cltbld', 17:12:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:58 INFO - '_': '/tools/buildbot/bin/python'} 17:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:58 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 17:12:58 INFO - Cleaning up... 17:12:58 INFO - Return code: 0 17:12:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:12:58 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')]} 17:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:58 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')]} 17:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:12:58 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:12:58 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 17:12:58 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 17:12:58 INFO - Using env: {'DISPLAY': ':0', 17:12:58 INFO - 'HOME': '/home/cltbld', 17:12:58 INFO - 'LANG': 'en_US.UTF-8', 17:12:58 INFO - 'LANGUAGE': 'en_US:en', 17:12:58 INFO - 'LOGNAME': 'cltbld', 17:12:58 INFO - 'MAIL': '/var/mail/cltbld', 17:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:12:58 INFO - 'MOZ_NO_REMOTE': '1', 17:12:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:12:58 INFO - 'NO_EM_RESTART': '1', 17:12:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:12:58 INFO - 'PWD': '/builds/slave/test', 17:12:58 INFO - 'SHELL': '/bin/bash', 17:12:58 INFO - 'SHLVL': '1', 17:12:58 INFO - 'TERM': 'linux', 17:12:58 INFO - 'TMOUT': '86400', 17:12:58 INFO - 'USER': 'cltbld', 17:12:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:12:58 INFO - '_': '/tools/buildbot/bin/python'} 17:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:12:58 INFO - Downloading/unpacking psutil>=3.1.1 17:12:58 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 17:12:58 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 17:12:58 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 17:12:58 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 17:12:58 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 17:12:58 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 17:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:00 INFO - Installing collected packages: psutil 17:13:00 INFO - Running setup.py install for psutil 17:13:01 INFO - building 'psutil._psutil_linux' extension 17:13:01 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 17:13:01 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 17:13:01 INFO - building 'psutil._psutil_posix' extension 17:13:01 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 17:13:01 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 17:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:01 INFO - Successfully installed psutil 17:13:01 INFO - Cleaning up... 17:13:01 INFO - Return code: 0 17:13:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:13:01 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')]} 17:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 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')]} 17:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:01 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:01 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 17:13:01 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 17:13:01 INFO - Using env: {'DISPLAY': ':0', 17:13:01 INFO - 'HOME': '/home/cltbld', 17:13:01 INFO - 'LANG': 'en_US.UTF-8', 17:13:01 INFO - 'LANGUAGE': 'en_US:en', 17:13:01 INFO - 'LOGNAME': 'cltbld', 17:13:01 INFO - 'MAIL': '/var/mail/cltbld', 17:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:01 INFO - 'MOZ_NO_REMOTE': '1', 17:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:01 INFO - 'NO_EM_RESTART': '1', 17:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:01 INFO - 'PWD': '/builds/slave/test', 17:13:01 INFO - 'SHELL': '/bin/bash', 17:13:01 INFO - 'SHLVL': '1', 17:13:01 INFO - 'TERM': 'linux', 17:13:01 INFO - 'TMOUT': '86400', 17:13:01 INFO - 'USER': 'cltbld', 17:13:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:01 INFO - '_': '/tools/buildbot/bin/python'} 17:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:13:01 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 17:13:01 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 17:13:01 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 17:13:01 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 17:13:01 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 17:13:01 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 17:13:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:13:03 INFO - Installing collected packages: mozsystemmonitor 17:13:03 INFO - Running setup.py install for mozsystemmonitor 17:13:03 INFO - Successfully installed mozsystemmonitor 17:13:03 INFO - Cleaning up... 17:13:04 INFO - Return code: 0 17:13:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:13:04 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')]} 17:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 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')]} 17:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:04 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:04 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 17:13:04 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 17:13:04 INFO - Using env: {'DISPLAY': ':0', 17:13:04 INFO - 'HOME': '/home/cltbld', 17:13:04 INFO - 'LANG': 'en_US.UTF-8', 17:13:04 INFO - 'LANGUAGE': 'en_US:en', 17:13:04 INFO - 'LOGNAME': 'cltbld', 17:13:04 INFO - 'MAIL': '/var/mail/cltbld', 17:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:04 INFO - 'MOZ_NO_REMOTE': '1', 17:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:04 INFO - 'NO_EM_RESTART': '1', 17:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:04 INFO - 'PWD': '/builds/slave/test', 17:13:04 INFO - 'SHELL': '/bin/bash', 17:13:04 INFO - 'SHLVL': '1', 17:13:04 INFO - 'TERM': 'linux', 17:13:04 INFO - 'TMOUT': '86400', 17:13:04 INFO - 'USER': 'cltbld', 17:13:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:04 INFO - '_': '/tools/buildbot/bin/python'} 17:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:04 INFO - Downloading/unpacking jsonschema==2.5.1 17:13:04 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 17:13:04 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 17:13:04 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 17:13:04 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 17:13:04 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 17:13:04 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 17:13:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:13:06 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 17:13:06 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 17:13:06 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 17:13:06 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 17:13:06 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 17:13:06 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 17:13:06 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:06 INFO - warning: no files found matching '*.txt' 17:13:06 INFO - no previously-included directories found matching 'build' 17:13:06 INFO - no previously-included directories found matching 'dist' 17:13:06 INFO - no previously-included directories found matching '.git*' 17:13:06 INFO - Installing collected packages: jsonschema, functools32 17:13:06 INFO - Running setup.py install for functools32 17:13:06 INFO - warning: no files found matching '*.txt' 17:13:06 INFO - no previously-included directories found matching 'build' 17:13:06 INFO - no previously-included directories found matching 'dist' 17:13:06 INFO - no previously-included directories found matching '.git*' 17:13:06 INFO - Successfully installed jsonschema functools32 17:13:06 INFO - Cleaning up... 17:13:06 INFO - Return code: 0 17:13:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:13:06 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')]} 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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')]} 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:06 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 17:13:06 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 17:13:06 INFO - Using env: {'DISPLAY': ':0', 17:13:06 INFO - 'HOME': '/home/cltbld', 17:13:06 INFO - 'LANG': 'en_US.UTF-8', 17:13:06 INFO - 'LANGUAGE': 'en_US:en', 17:13:06 INFO - 'LOGNAME': 'cltbld', 17:13:06 INFO - 'MAIL': '/var/mail/cltbld', 17:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:06 INFO - 'MOZ_NO_REMOTE': '1', 17:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:06 INFO - 'NO_EM_RESTART': '1', 17:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:06 INFO - 'PWD': '/builds/slave/test', 17:13:06 INFO - 'SHELL': '/bin/bash', 17:13:06 INFO - 'SHLVL': '1', 17:13:06 INFO - 'TERM': 'linux', 17:13:06 INFO - 'TMOUT': '86400', 17:13:06 INFO - 'USER': 'cltbld', 17:13:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:06 INFO - '_': '/tools/buildbot/bin/python'} 17:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:13:06 INFO - Cleaning up... 17:13:06 INFO - Return code: 0 17:13:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:06 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')]} 17:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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')]} 17:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:06 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:06 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 17:13:06 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 17:13:06 INFO - Using env: {'DISPLAY': ':0', 17:13:06 INFO - 'HOME': '/home/cltbld', 17:13:06 INFO - 'LANG': 'en_US.UTF-8', 17:13:06 INFO - 'LANGUAGE': 'en_US:en', 17:13:06 INFO - 'LOGNAME': 'cltbld', 17:13:06 INFO - 'MAIL': '/var/mail/cltbld', 17:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:06 INFO - 'MOZ_NO_REMOTE': '1', 17:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:06 INFO - 'NO_EM_RESTART': '1', 17:13:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:06 INFO - 'PWD': '/builds/slave/test', 17:13:06 INFO - 'SHELL': '/bin/bash', 17:13:06 INFO - 'SHLVL': '1', 17:13:06 INFO - 'TERM': 'linux', 17:13:06 INFO - 'TMOUT': '86400', 17:13:06 INFO - 'USER': 'cltbld', 17:13:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:06 INFO - '_': '/tools/buildbot/bin/python'} 17:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:07 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:07 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 17:13:07 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 17:13:07 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 17:13:07 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 17:13:07 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 17:13:07 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 17:13:09 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 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 17:13:09 INFO - Downloading docopt-0.6.1.tar.gz 17:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:10 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:10 INFO - Running setup.py install for blobuploader 17:13:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:10 INFO - Running setup.py install for requests 17:13:10 INFO - Running setup.py install for docopt 17:13:10 INFO - Successfully installed blobuploader requests docopt 17:13:10 INFO - Cleaning up... 17:13:10 INFO - Return code: 0 17:13:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:10 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')]} 17:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:10 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')]} 17:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:10 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:10 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 17:13:10 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 17:13:10 INFO - Using env: {'DISPLAY': ':0', 17:13:10 INFO - 'HOME': '/home/cltbld', 17:13:10 INFO - 'LANG': 'en_US.UTF-8', 17:13:10 INFO - 'LANGUAGE': 'en_US:en', 17:13:10 INFO - 'LOGNAME': 'cltbld', 17:13:10 INFO - 'MAIL': '/var/mail/cltbld', 17:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:10 INFO - 'MOZ_NO_REMOTE': '1', 17:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:10 INFO - 'NO_EM_RESTART': '1', 17:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:10 INFO - 'PWD': '/builds/slave/test', 17:13:10 INFO - 'SHELL': '/bin/bash', 17:13:10 INFO - 'SHLVL': '1', 17:13:10 INFO - 'TERM': 'linux', 17:13:10 INFO - 'TMOUT': '86400', 17:13:10 INFO - 'USER': 'cltbld', 17:13:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:10 INFO - '_': '/tools/buildbot/bin/python'} 17:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:10 INFO - Running setup.py (path:/tmp/pip-aJYuou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:10 INFO - Running setup.py (path:/tmp/pip-RC6JKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:10 INFO - Running setup.py (path:/tmp/pip-5cJnRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:11 INFO - Running setup.py (path:/tmp/pip-WRztUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:11 INFO - Running setup.py (path:/tmp/pip-ayNQkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:11 INFO - Running setup.py (path:/tmp/pip-RMqtKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:11 INFO - Running setup.py (path:/tmp/pip-_9_aYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:11 INFO - Running setup.py (path:/tmp/pip-qP7oaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:11 INFO - Running setup.py (path:/tmp/pip-8GHLdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:11 INFO - Running setup.py (path:/tmp/pip-PEWoWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:11 INFO - Running setup.py (path:/tmp/pip-r126la-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:11 INFO - Running setup.py (path:/tmp/pip-6qlxZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:11 INFO - Running setup.py (path:/tmp/pip-hxgPs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:11 INFO - Running setup.py (path:/tmp/pip-fUbEoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:11 INFO - Running setup.py (path:/tmp/pip-NeGs6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:11 INFO - Running setup.py (path:/tmp/pip-u6FK2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:11 INFO - Running setup.py (path:/tmp/pip-AFZlp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:12 INFO - Running setup.py install for manifestparser 17:13:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Running setup.py install for mozcrash 17:13:12 INFO - Running setup.py install for mozdebug 17:13:12 INFO - Running setup.py install for mozdevice 17:13:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Running setup.py install for mozfile 17:13:12 INFO - Running setup.py install for mozhttpd 17:13:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Running setup.py install for mozinfo 17:13:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Running setup.py install for mozInstall 17:13:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:12 INFO - Running setup.py install for mozleak 17:13:12 INFO - Running setup.py install for mozlog 17:13:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Running setup.py install for moznetwork 17:13:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Running setup.py install for mozprocess 17:13:13 INFO - Running setup.py install for mozprofile 17:13:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Running setup.py install for mozrunner 17:13:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Running setup.py install for mozscreenshot 17:13:13 INFO - Running setup.py install for moztest 17:13:13 INFO - Running setup.py install for mozversion 17:13:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:13 INFO - Cleaning up... 17:13:13 INFO - Return code: 0 17:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:13 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')]} 17:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:13 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')]} 17:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:13 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:13 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 17:13:13 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 17:13:13 INFO - Using env: {'DISPLAY': ':0', 17:13:13 INFO - 'HOME': '/home/cltbld', 17:13:13 INFO - 'LANG': 'en_US.UTF-8', 17:13:13 INFO - 'LANGUAGE': 'en_US:en', 17:13:13 INFO - 'LOGNAME': 'cltbld', 17:13:13 INFO - 'MAIL': '/var/mail/cltbld', 17:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:13 INFO - 'MOZ_NO_REMOTE': '1', 17:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:13 INFO - 'NO_EM_RESTART': '1', 17:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:13 INFO - 'PWD': '/builds/slave/test', 17:13:13 INFO - 'SHELL': '/bin/bash', 17:13:13 INFO - 'SHLVL': '1', 17:13:13 INFO - 'TERM': 'linux', 17:13:13 INFO - 'TMOUT': '86400', 17:13:13 INFO - 'USER': 'cltbld', 17:13:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:13 INFO - '_': '/tools/buildbot/bin/python'} 17:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:14 INFO - Running setup.py (path:/tmp/pip-6qQBL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:14 INFO - Running setup.py (path:/tmp/pip-Zj3mHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:14 INFO - Running setup.py (path:/tmp/pip-8lKp_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:14 INFO - Running setup.py (path:/tmp/pip-4bH9NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:14 INFO - Running setup.py (path:/tmp/pip-yFU5Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:14 INFO - Running setup.py (path:/tmp/pip-KjkBtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:14 INFO - Running setup.py (path:/tmp/pip-a1AMz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:14 INFO - Running setup.py (path:/tmp/pip-dxzY8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:14 INFO - Running setup.py (path:/tmp/pip-MGJZl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:14 INFO - Running setup.py (path:/tmp/pip-6hW2Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:14 INFO - Running setup.py (path:/tmp/pip-_3qQaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:14 INFO - Running setup.py (path:/tmp/pip-TyjgKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:14 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)) 17:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:15 INFO - Running setup.py (path:/tmp/pip-TFeo8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:15 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)) 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:15 INFO - Running setup.py (path:/tmp/pip-xt0r7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:15 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)) 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:15 INFO - Running setup.py (path:/tmp/pip-8yEZs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:15 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)) 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:15 INFO - Running setup.py (path:/tmp/pip-IwglET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:15 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)) 17:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:15 INFO - Running setup.py (path:/tmp/pip-Z9BdpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:15 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)) 17:13:15 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)) 17:13:15 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)) 17:13:15 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)) 17:13:15 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)) 17:13:15 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)) 17:13:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:15 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 17:13:15 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 17:13:15 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 17:13:15 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 17:13:15 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 17:13:15 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 17:13:17 INFO - Downloading blessings-1.6.tar.gz 17:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:17 INFO - Installing collected packages: blessings 17:13:17 INFO - Running setup.py install for blessings 17:13:17 INFO - Successfully installed blessings 17:13:17 INFO - Cleaning up... 17:13:17 INFO - Return code: 0 17:13:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:17 INFO - Reading from file tmpfile_stdout 17:13:17 INFO - Current package versions: 17:13:17 INFO - argparse == 1.2.1 17:13:17 INFO - blessings == 1.6 17:13:17 INFO - blobuploader == 1.2.4 17:13:17 INFO - docopt == 0.6.1 17:13:17 INFO - functools32 == 3.2.3-2 17:13:17 INFO - jsonschema == 2.5.1 17:13:17 INFO - manifestparser == 1.1 17:13:17 INFO - mozInstall == 1.12 17:13:17 INFO - mozcrash == 1.0 17:13:17 INFO - mozdebug == 0.1 17:13:17 INFO - mozdevice == 0.48 17:13:17 INFO - mozfile == 1.2 17:13:17 INFO - mozhttpd == 0.7 17:13:17 INFO - mozinfo == 0.9 17:13:17 INFO - mozleak == 0.1 17:13:17 INFO - mozlog == 3.4 17:13:17 INFO - moznetwork == 0.27 17:13:17 INFO - mozprocess == 0.23 17:13:17 INFO - mozprofile == 0.28 17:13:17 INFO - mozrunner == 6.13 17:13:17 INFO - mozscreenshot == 0.1 17:13:17 INFO - mozsystemmonitor == 0.3 17:13:17 INFO - moztest == 0.8 17:13:17 INFO - mozversion == 1.4 17:13:17 INFO - psutil == 3.1.1 17:13:17 INFO - requests == 1.2.3 17:13:17 INFO - wsgiref == 0.1.2 17:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:17 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')]} 17:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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')]} 17:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:17 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:17 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 17:13:17 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 17:13:17 INFO - Using env: {'DISPLAY': ':0', 17:13:17 INFO - 'HOME': '/home/cltbld', 17:13:17 INFO - 'LANG': 'en_US.UTF-8', 17:13:17 INFO - 'LANGUAGE': 'en_US:en', 17:13:17 INFO - 'LOGNAME': 'cltbld', 17:13:17 INFO - 'MAIL': '/var/mail/cltbld', 17:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:17 INFO - 'MOZ_NO_REMOTE': '1', 17:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:17 INFO - 'NO_EM_RESTART': '1', 17:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:17 INFO - 'PWD': '/builds/slave/test', 17:13:17 INFO - 'SHELL': '/bin/bash', 17:13:17 INFO - 'SHLVL': '1', 17:13:17 INFO - 'TERM': 'linux', 17:13:17 INFO - 'TMOUT': '86400', 17:13:17 INFO - 'USER': 'cltbld', 17:13:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:17 INFO - '_': '/tools/buildbot/bin/python'} 17:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 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)) 17:13:18 INFO - Cleaning up... 17:13:18 INFO - Return code: 0 17:13:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13:18 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')]} 17:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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')]} 17:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:18 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 0x7f573c206f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', '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 17:13:18 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 17:13:18 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 17:13:18 INFO - Using env: {'DISPLAY': ':0', 17:13:18 INFO - 'HOME': '/home/cltbld', 17:13:18 INFO - 'LANG': 'en_US.UTF-8', 17:13:18 INFO - 'LANGUAGE': 'en_US:en', 17:13:18 INFO - 'LOGNAME': 'cltbld', 17:13:18 INFO - 'MAIL': '/var/mail/cltbld', 17:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:18 INFO - 'MOZ_NO_REMOTE': '1', 17:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:18 INFO - 'NO_EM_RESTART': '1', 17:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:18 INFO - 'PWD': '/builds/slave/test', 17:13:18 INFO - 'SHELL': '/bin/bash', 17:13:18 INFO - 'SHLVL': '1', 17:13:18 INFO - 'TERM': 'linux', 17:13:18 INFO - 'TMOUT': '86400', 17:13:18 INFO - 'USER': 'cltbld', 17:13:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:18 INFO - '_': '/tools/buildbot/bin/python'} 17:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:13:18 INFO - Cleaning up... 17:13:18 INFO - Return code: 0 17:13:18 INFO - Running post-action listener: _resource_record_post_action 17:13:18 INFO - Running post-action listener: _start_resource_monitoring 17:13:18 INFO - Starting resource monitoring. 17:13:18 INFO - [mozharness: 2017-02-01 01:13:18.336106Z] Finished create-virtualenv step (success) 17:13:18 INFO - [mozharness: 2017-02-01 01:13:18.336630Z] Running install step. 17:13:18 INFO - Running pre-action listener: _resource_record_pre_action 17:13:18 INFO - Running main action method: install 17:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:18 INFO - Reading from file tmpfile_stdout 17:13:18 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:18 INFO - Reading from file tmpfile_stdout 17:13:18 INFO - Output received: 17:13:18 INFO - Usage: mozinstall [options] installer 17:13:18 INFO - Options: 17:13:18 INFO - -h, --help show this help message and exit 17:13:18 INFO - -d DEST, --destination=DEST 17:13:18 INFO - Directory to install application into. [default: 17:13:18 INFO - "/builds/slave/test"] 17:13:18 INFO - --app=APP Application being installed. [default: firefox] 17:13:18 INFO - mkdir: /builds/slave/test/build/application 17:13:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:13:32 INFO - Reading from file tmpfile_stdout 17:13:32 INFO - Output received: 17:13:32 INFO - /builds/slave/test/build/application/firefox/firefox 17:13:32 INFO - Running post-action listener: _resource_record_post_action 17:13:32 INFO - [mozharness: 2017-02-01 01:13:32.258891Z] Finished install step (success) 17:13:32 INFO - [mozharness: 2017-02-01 01:13:32.259131Z] Running run-tests step. 17:13:32 INFO - Running pre-action listener: _resource_record_pre_action 17:13:32 INFO - Running main action method: run_tests 17:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:13:32 INFO - Python 2.7.3 17:13:32 INFO - Return code: 0 17:13:32 INFO - grabbing minidump binary from tooltool 17:13:32 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')]} 17:13:32 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 0x26eff60>, '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 0x26f0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:13:32 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 17:13:32 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 17:13:32 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 17:13:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:13:32 INFO - Return code: 0 17:13:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:13:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:13:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:13:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:13:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:13:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 17:13:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 17:13:32 INFO - Using env: {'DISPLAY': ':0', 17:13:32 INFO - 'HOME': '/home/cltbld', 17:13:32 INFO - 'LANG': 'en_US.UTF-8', 17:13:32 INFO - 'LANGUAGE': 'en_US:en', 17:13:32 INFO - 'LOGNAME': 'cltbld', 17:13:32 INFO - 'MAIL': '/var/mail/cltbld', 17:13:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:13:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:32 INFO - 'MOZ_NO_REMOTE': '1', 17:13:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:13:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:32 INFO - 'NO_EM_RESTART': '1', 17:13:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:32 INFO - 'PWD': '/builds/slave/test', 17:13:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:13:32 INFO - 'SHELL': '/bin/bash', 17:13:32 INFO - 'SHLVL': '1', 17:13:32 INFO - 'TERM': 'linux', 17:13:32 INFO - 'TMOUT': '86400', 17:13:32 INFO - 'USER': 'cltbld', 17:13:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769', 17:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:32 INFO - '_': '/tools/buildbot/bin/python'} 17:13:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 17:13:32 INFO - mozversion application_buildid: 20170131151409 17:13:32 INFO - mozversion application_changeset: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 17:13:32 INFO - mozversion application_display_name: Firefox 17:13:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:13:32 INFO - mozversion application_name: Firefox 17:13:32 INFO - mozversion application_remotingname: firefox 17:13:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:13:32 INFO - mozversion application_vendor: Mozilla 17:13:32 INFO - mozversion application_version: 52.0 17:13:32 INFO - mozversion platform_buildid: 20170131151409 17:13:32 INFO - mozversion platform_changeset: c16a0fc964a5790de244fc3ea3bb5c3d3c18d071 17:13:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:13:32 INFO - mozversion platform_version: 52.0 17:13:32 INFO - using testdate: 1485911612 17:13:32 INFO - actual date: 1485911612 17:13:32 INFO - starting webserver on 'localhost:42653' 17:13:32 INFO - SUITE-START | Running 2 tests 17:13:32 INFO - TEST-START | dromaeo_css 17:13:32 INFO - operating with platform_type : linux_ 17:13:32 INFO - Initialising browser for dromaeo_css test... 17:13:32 INFO - TEST-INFO | started process 9873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nQhrl/profile http://localhost:42653/getInfo.html) 17:13:36 INFO - PROCESS | 9873 | __metrics Screen width/height:1600/1200 17:13:36 INFO - PROCESS | 9873 | colorDepth:24 17:13:36 INFO - PROCESS | 9873 | Browser inner width/height: 1024/697 17:13:36 INFO - PROCESS | 9873 | __metrics 17:13:37 INFO - PROCESS | 9873 | 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" 17:13:37 INFO - PROCESS | 9873 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:37 INFO - PROCESS | 9873 | console.error: PushService: 17:13:37 INFO - PROCESS | 9873 | stateChangeProcessEnqueue: Error transitioning state 17:13:37 INFO - PROCESS | 9873 | UnknownError 17:13:38 INFO - TEST-INFO | 9873: exit 0 17:13:38 INFO - Browser initialized. 17:13:38 INFO - Running cycle 1/1 for dromaeo_css test... 17:13:38 INFO - TEST-INFO | started process 9969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0nQhrl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:50 INFO - PROCESS | 9969 | RSS: Main: 141434880 17:13:50 INFO - PROCESS | 9969 | 17:16:52 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42653/tests/dromaeo/cssquery-ext.html) 17:16:53 INFO - PROCESS | 9969 | RSS: Main: 240218112 17:16:53 INFO - PROCESS | 9969 | 17:19:55 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-ext.html (next: http://localhost:42653/tests/dromaeo/cssquery-jquery.html) 17:19:56 INFO - PROCESS | 9969 | RSS: Main: 235610112 17:19:56 INFO - PROCESS | 9969 | 17:22:58 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42653/tests/dromaeo/cssquery-mootools.html) 17:22:58 INFO - PROCESS | 9969 | RSS: Main: 223825920 17:22:58 INFO - PROCESS | 9969 | 17:26:00 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42653/tests/dromaeo/cssquery-prototype.html) 17:26:01 INFO - PROCESS | 9969 | RSS: Main: 215588864 17:26:01 INFO - PROCESS | 9969 | 17:29:03 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42653/tests/dromaeo/cssquery-yui.html) 17:29:04 INFO - PROCESS | 9969 | RSS: Main: 177348608 17:29:04 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | Cycle 1(1): loaded http://localhost:42653/tests/dromaeo/cssquery-yui.html (next: http://localhost:42653/tests/dromaeo/cssquery-dojo.html) 17:32:06 INFO - PROCESS | 9969 | RSS: Main: 265830400 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | __start_tp_report 17:32:06 INFO - PROCESS | 9969 | _x_x_mozilla_page_load 17:32:06 INFO - PROCESS | 9969 | _x_x_mozilla_page_load_details 17:32:06 INFO - PROCESS | 9969 | |i|pagename|runs| 17:32:06 INFO - PROCESS | 9969 | |0;dojo.html;3220.5169224616307;3259.348130373926;3270.3295824356;3284.1953721338277;3302.4881143422763;5579.609427340083;5677.148427735837;5678.744456499458;5679.034564124098;5691.658500489973;5634.830955071355;5656.745446454919;5660.773569057233;5712.1431785232235;5745.396733342991;5070.492950704927;5091.592672586203;5098.082345177866;5145.073886700392;5165.483451654842;4895.069936712031;4912.091263116335;5071;5179.922301165486;5182.507661772144;5114.43741188469;5208.973955130219;5224.869378265555;5226.634135610509;5228.241904923784;5218.399884013311;5219.530242278194;5226.660267082647;5233.058049551079;5264;4898.730569818658;4927.802887884481;5111.284420181178;5122.795088196468;5189.844304670866;5491.890162196773;5549.833504994856;5553.389127196006;5557.777688892439;5594.328680558318;6001.5798894077;6010.819675409744;6051.848703782397;6099;6105.236845394325;5824.708764561755;6113.908291375633;6142;6143.109249158847;6144.170536977495;5478.150886612581;5607;5656.4060773619;5665.461781130868;5699.5155411790465;6215.9378406215355;6218.751249949952;6221.160143380585;6237.4698150656795;6240.469560087353;5672.489475947102;5969.044952807617;5974.761009559569;5982.40175982407;5984.3417224105315;5822.737976791054;5945.613535120204;6000.21997140369;6007.819765406957;6091.695415229221;6038.939610603926;6043.153958445821;6043.939560604338;6046.516278697693;6069.2110025696375;5984.640921544721;6019.849503762441;6033.909491357633;6044.093385992049;6061.787837425669;4548.044910568751;4561.338605902126;4638.884027899262;4639.628829693616;4697.718136911796;4186.246475634415;4210.5157906840495;4213.410122582841;4222.472190976128;4247.108107297502;5793.478586927196;5801.8549536261935;5814.941850581525;5821.98115329824;5829.533637309005;5817.767289308465;5892;6012.669303188279;6080.635161890301;6087.299960504599;5793.362730099686;5820.243368362086;5825.533957283407;5834.15404766315;5838.38696936824;5262.631615786935;5290.92063619046;5297.443768404339;5304.363476382781;5305.07161246788;6050.757969681164;6147.784827531015;6345.524085693592;6381.138546296191;6398.93601064002;6024.246969128859;6076.997295446378;6095.664738439428;6120.690942950841;6160.876782464416;6340.714667839866;6354.301026887131;6361.109444677842;6368.968155159195;6373.075903993802;5654.830355089354;5951.1370851225465;6006.069059295816;6015.368386319374;6034.668093254913;5836.912446313394;5973.611715238496;6014.669193194241;6037.577369584087;6122.755089796358;5961.433663801932;5970.343262241063;5977.402259774161;5977.46202841729;5981.730822112929;5963.970180149072;5964.612300200473;5969.224000879858;5972.402759723993;5975.940240597713;5580.5535557156145;5687.374388817144;5797.6521408713925;5797.884042319214;5821.039528477754;5923.940760592512;5968.940310596839;5970.850728731816;5972.880542389041;5994.6403215807195;5552.472515111058;5607.41122182165;5788.710564471676;5809.651420914759;5818.33089194748 17:32:06 INFO - PROCESS | 9969 | |1;ext.html;590.1825971030124;635.6694518850198;646.1696719715166;663.23396477069;668.048031555034;35295;37601.62398376015;37898.24203515928;37927;44903.326450103195;43686.781566092126;48078.75960620201;48155.51844481554;48172.75913620436;48183.51816481834;8862.42394244372;9017.684381046665;9032.458052516837;9051.185393314601;9061.139191776803;8470.915290847104;8688.739337819876;8994.865077023816;9081.455112693227;10653.201009924247;10631.202659800507;10682.465876706172;10684.679459616224;10699.518521666543;10700.411477368742;10960.945195274013;11005.944970275097;11025.503852326585;11031;11037.889621103766;10853.620123295646;10945.945270273678;10954.890451095467;10979.121670266359;10983.450827458595;44823.32765008527;45206;45244;45249;45290.773546132055;3731.9253614927547;3753.699704023699;3950.4469374287623;4070.7964601769795;4086.8978275543054;32598.837005815058;32802.17994550155;32899.34201315984;32978.17554561131;33219;3733.775973441575;3790.54513458384;3811.7522361046445;3812.370958791796;3840.1743625120453;354160;355219;355694.99999999744;355869;356013;38142.42786358207;63581;63653.681731591045;63836.36163638397;64017;39183.80408097941;41875.58124418778;41963.160736785096;42034.57965420368;42071.57928420677;16825.158742063093;16974.236159372856;16987.150642467826;17001.914990425215;17004.319827207022;13022.413991370411;13035.804462933063;13043.021773367036;13046.41291141901;13069.803952940714;8778.517181555077;9040.547972601475;9086.500242486594;9091.636334546543;9541.332106752461;3593.083763640255;3645.781253124821;3660.5058317126845;3703.666669999713;3715.535558055243;1048.2190767877828;1069.9354142627978;1114.331401159314;1127.3912087472836;1169.6140273709655;33115.337693246;33885.66114338825;34131.82934085314;34191.48712769311;34338.82830585881;1127.261643623428;1132.17351333527;1167.6963989362657;1169.2049406403728;1196.8683444821063;16627.168641567874;17893.10534473271;17931.013928351418;19100.140493677816;19321.227150913805;569344;572701;573416;574310;576800;64216.67891660512;64464.355356445834;64590.677046615405;64627.35372646307;64750.67624661847;1305.223392081729;1346.4210389532595;1387.5074348606302;1420.4957240179588;1447.182341976801;32317.35365292634;33898.8305058483;33925;34111.14722131967;34743.30513389769;54384.45615543794;54613;55063.724681376334;55158.44841551533;55230.72384638051;450053;455284;456925;456949;458098;26640;27574.862125689244;28903.710962890942;29537.852310738308;29774.851125744233;47755.5224447765;48399.75800120977;48522.75738621284;48860;49050.75474622604;40751.59248407597;40901.59098408978;41335.793321034405;42834.14331713286;43060.569394305654;40687;40845.38731919083;40951;41071;42550.14899702051;40993.59006409898;41135.1772964545;41641.79179104085;41958.58041419669;42222.366664500674;35269.64730352664;38014.61985380111;38143.80928095342;38390.424143638425;38907.22185556329;28427.43145137127;28636.57045144283;28664.713352866205;28673.28316792097;28726.569101463912 17:32:06 INFO - PROCESS | 9969 | |2;jquery.html;408.2997659014789;408.99182016359674;424.295669189146;427.68137737385655;430.37165738022486;18536.62926741466;20153.798462015395;20365.796342036592;20959.266425675105;21259.893700531476;16665.750013749774;19460.41618751436;19717.507062323413;20409.285675001378;20485.897570512127;5555.416681248461;5824.388439213885;5826.300843898717;5831.854203644901;5833.591648584601;5748.137779333113;5760.51876494955;5819.9418005819825;5828.125781132821;5865.266841644794;5561.888762224753;5687.516561092312;5694.117411801157;5696.743646535916;5696.800611978581;5591.832245032656;5709.229254050691;5743.994800909824;5820.214271073435;5851.3270973838125;5778.3066032076;5786.1610066540115;5788.594798364116;5789.536837053068;5792.739326730307;14596.70806583873;14848.925755371154;15017.399304027826;15021.02363346379;15028.398864045424;2160.092761040367;2241.820654347648;2242.316093591454;2421.225207933462;2558.6417901493805;10299.53652085658;10441.42572158531;10710.51802668874;10849.945750271198;10897.237193396466;1831.6611426886068;1892.8485721142276;1903.8286554210188;1910.646530391868;1930.94207173785;83927;84942.5752871238;85989;86616;86835.56582217048;10924.126069914546;11412.657620271406;11462.197646164856;11479.196456247982;11637.88362116368;15783.684326313409;16379.590510237102;16407.91796041036;16475.34098636065;16557.91721041387;8017.719379821795;8157.184281571914;8242.670293188205;8395.160483951679;8429.325653947792;7401.851962960711;7651.69393224276;7807.726729564438;8146.0632027317615;8189.344852411793;4798.376211092535;4799.3760811095035;4817.8313759018965;4832.202686556749;4981.028699403654;1943.1741509858255;1951.9804801952082;1957.4421289932302;1989.7512810898638;1995.966131480142;940.041158018817;1007.6725064354114;1009.8737657792776;1018.9301233704581;1066.7866426714688;19872.60254794896;20211.8989405052;20240.696389554167;20624.27815026467;20698.793012069687;1009.9545520451597;1011.0597144655541;1013.6857574152036;1026.5637104230673;1035.2649618770606;10348.223883208639;11106.833397499044;11132.220744547803;11192.720181995515;11285.54857805695;484498;485026;485502;506986;507460;95241;98719.50640246896;98886;101667.49166254122;103115.48442257891;989.5200827598609;1006.7483129217695;1008.4604736465956;1020.6070662794729;1029.325791606484;17410.39063632767;17423.82576174222;17878.463646090637;18099.366522171662;18191.45425637233;43028.78485607552;43118;43138.78430607827;43427.565724342356;44241.11517769691;55496.167557487475;59917.700411499405;60056;61026;61855;8762.167594078552;8796.780080498038;8943.418677786183;9053.954730226307;9102.13529714676;13157.539486118323;13364.997625177955;13368.264745438706;13398;13835.031547791557;11295.152863535104;11403.543858245577;11407.429628518375;11629.302241865515;11906.404679765803;11558;11854.229475084092;11997.880021199677;12030.518779249081;12068.39658017078;11337.546498139982;11345.943270283597;11533.423328833693;11672.941635291769;12018.75962480763;8664.696735614223;8768.561571921506;8817.955910220408;8977.236934860348;9081.954590227007;9896.752581185528;10985.945070274598;11060.557577697124;11166.497507612014;11188.944055279671 17:32:06 INFO - PROCESS | 9969 | |3;mootools.html;1368.165419094353;1498.4380857178558;1528.8165420149583;1693.6104695919937;1812.7915289741675;7871.330936870366;8621.913780862189;8918.866217006742;8920;9180.586873590688;8990.280777537797;9006.234470070052;9052.954735226314;9065.773355666111;9067.546622668873;2456.0912462388897;2478.1698131126095;2482.304954612702;2483.689538807649;2489.3278814720015;2419.322589674894;2493.7256901740793;2499.6500489931423;2501.8123640726926;2503.0613519930025;2402.2192787344184;2435.2329016359877;2492.464120214154;2497.8376405533672;2498.2130628851855;2353.682252895854;2357.2574638988835;2371.6086845670443;2372.905083796646;2376.4652953085592;2398.556267090594;2433.75662433757;2462.839915405493;2463.8521688698734;2465.1248806673552;8889.199972002487;9014.55767077271;9090.2273306769;9138.54307284633;9194.54027298639;5404.702741349224;5659.886802263973;5664.858378540528;5667.518260947824;5669.518090962273;3481.930361392783;3574.3566158091535;3644.234710710754;3656;3719.9628003719886;1042.2339580408393;1080.8000519903842;1086.3101930274254;1113.5935383584933;1127.7518945831987;12626.684332891751;12653.74692506154;12710.428030738547;12726.10917235794;12790.744185116246;4271;4482;4569.885752856205;4578.633709303248;4597.057603191338;10129.594816207416;10132.189424845994;10132.34139780912;10132.392056476636;10144.289899707097;5389.164679474688;5400.891982160335;5405.540529055074;5415.431379705153;5420.132778755459;4302.741835489881;4518.954810451919;4622.2835460503675;5072.391313042459;5167.793288268503;4022.2960981828064;4052.7365721228025;4153.439285696452;4159.688023398257;4164.167166566699;1228.2875931959443;1250.781113305168;1251.6307689231699;1252.6242127361754;1256.4534427524056;963.2823546457794;976.3214565876648;984.9950750246203;987.1214618989105;993.5677980078689;5971.6563773151565;6045.879082418415;6051.122587224828;6156.07658851167;6231.4391704745885;434.9934750978738;438.9539098394686;440.61886468204773;1043.3114144664485;1081.1891081688734;4206.915861682749;4296.269634162138;4321.827126914951;4362.672799540047;4363.952651363713;11021.669349919515;11424.771504569862;11430.942845285721;11439.59961401347;11443.828342574869;10575.576976920991;11328.71678208035;11336.773264534828;11339.773204535863;11358.716032099099;8423.536705481134;8668.78328041804;8697.391182617283;8698.869516957251;8700.434471759316;5890.705464726832;6136.570440069152;6185.226846644169;6221.129041934042;6276.905846412216;10079.294449388472;10241.48792560354;10248.538815753458;10322.225833062701;10600.681979540626;9286.30352723535;9589.616415343307;10675.306105103144;10714.464276786286;10733;7505.962470187614;7857;7996.20037996219;8058.597070146352;8181.386396020203;8826.867596986178;8846.778830529289;8884.333674974274;8887;8890.33322500828;7683.409376380734;7686.961565192139;7765.22347765219;7874.291313781787;7988.281054705104;7593.392528597588;7730.536167829723;7736.226377362219;7739.419543534144;7799.766007019798;6826.692798824164;6906.654667266717;6924.099867017256;6960.4779641526075;6965.65171741421;4936.333594964633;5241.213817927189;5258.474152584711;5271.341082364705;5408.242846001484;5019.874503137305;5082.390113186441;5104.566111880383;5130.153524668388;5298.231756395378 17:32:06 INFO - PROCESS | 9969 | |4;prototype.html;336.9444041733114;341.5338063543263;355.38873138202314;355.8292019830481;357.6888107346609;5454.409155651068;5464.781408743655;5484.61607687462;5496.203050557671;5504.4495550444935;5147.845564633067;5212.687238765668;5245.659032162906;5302.655327403726;5402.91895621566;4246.851360202386;4249.787510624456;4261.5936740875595;4278.208531421681;4289.163613095432;4248.235317642823;4258.936115958263;4268.914621707564;4275.786210689469;4280.3793449949735;4092.6930480213955;4226.535081141087;4233.534311225762;4250.851220207293;4258.723182993111;4224.556421575721;4226.239276930151;4228.682848786338;4229.429027081335;4233.894152646178;3756.7834977363214;3769.453429252743;3782.9621703782886;3785.62143785622;3803.4215800442785;5059.949400505985;5231.869203269911;5262.92105618416;5286.365636123652;5304.389995150568;4786;4791.113643975876;4806.927896081562;4811.494793046715;4827.541383568555;5632.267805185341;5642.294713160855;5663.66018038919;5665.291838520185;5671.6597004179885;4013.819378127962;4016.9397459038137;4078.1843631273864;4131.29767939448;4133.318002529579;5759.544273435947;5793;5801.3038435388025;5830.825075247707;5856.824295271149;4173.622704507506;4209.452771139732;4220.092680073737;4220.683448741357;4229.344451610005;4121.196366708463;4217.662586993033;4269.658427325807;4270.423492828429;4279.786010699515;4804.159272127434;4807.206810876236;4818.759062046884;4819.204831202812;4835.734034628059;5689.886202275931;5694.800681976111;5700.572457065737;5712;5730.398308177665;1392.9094608850392;1423.7437261293067;1426.9286535673175;1428.7499687554637;1429.349645911108;968.9709308720609;987.53585814667;993.5791817700757;998.7203582996773;1010.5351538292321;5162.664426812245;5308.867278317995;5318.414974352818;5338.652987555796;5357.11607584752;5555.777768889199;5556.138588626861;5556.722163891789;5569;5573.247611572467;5261.605379596469;5271.367435907716;5311.3891902431715;5322.760475778599;5361.249425080492;2834.971650283471;2974.962150926622;2995.4907665696883;3014.7940823670706;3026.8789248429816;5792.82621521355;5875.559333050039;5885.529157667376;5905.350411454737;5932.644041357532;5511.751971161308;5727.198192253088;5761.971190144022;5791.484579847672;5817.680027598438;5895;5897.911531327033;5906.936751384792;5907.497862681635;5911.615744976562;5610.242617246783;5612.102063669793;5643.238162847963;5697.857553561194;5702.6293290935955;5446.754896029609;5788.363280039108;5827.213326200908;5836.315294964364;5850.678212698343;6082.482988945989;6119.816405507842;6120.632762034292;6125.509959203164;6146.323904370426;4012.859549915739;4182.121754431481;4220.5568415317175;4242.8727138185905;4247.617714405718;5555.833325000256;5662.348829884616;5676.829695109153;5792.478676919098;5846.619969701956;5672.347680016685;5682.147677848356;5706.657600543981;5715.257016587817;5733.8566535836935;5565.220869078251;5610.438956104357;5715;5717.914231286617;5733.827985160452;5601.859953501032;5623.3814280428305;5635.549156067423;5658.151277308437;5688.975984322861;5707.5433965281845;5708.914366284426;5715.428457154251;5734.340550836707;5734.397888221677;5394.379646340721;5540.36285827135;5603.907238088534;5610.691411972381;5617.9719101404235 17:32:06 INFO - PROCESS | 9969 | |5;yui.html;754.2419868032626;756.1417790807435;788.585992354014;795.8050277681969;832.6253186066269;13711.588652340433;14033.578992630211;14059.859401405984;14452.20512871793;14548.127112373251;12323.322217278046;12460.12779105463;12470.875291247108;12490.375481225925;12501.812472812915;743.297583783325;762.329150347696;853.2320911179926;865.8354912566608;883.5493898111977;871.6644092024553;875.2254254984321;878.3982971664431;879.1252703559967;883.3551507399602;924.2559739409772;928.8606708993638;929.2101713543468;929.2705226397279;929.3726734454216;922.1746536849515;923.187594916476;923.8798956135727;924.5007695844304;924.6070420071476;676.1716896801428;680.2755065854849;680.93190680932;681.1621705302456;681.6762038031944;12864.29246391448;13118.737625247442;13138.474461021548;13179.472821087145;14218.28908554568;14555.854441455662;15059.623509412353;15124.957818051877;15222.771658425132;15242.161681107535;10786.5685372585;10931.726706832313;11333.376664283462;11382.886171138265;11812.055035597132;3431.9485207721655;3436.381451338758;3472.4270495368232;3496.3356962177104;3544.131687736495;67070.66464667695;67740.6612966932;68381.316186838;69456.305436946;70125.64937175333;8847.380683352103;8909.955450222707;8926.464412135292;8945.46327220369;9126.771830704285;19934;19990.300339488047;20283.59432811365;20388.592228155652;20526.07632656534;7575.431842611826;7622.885656715153;7751.7674469766;7796.376289896794;8069.9596502018285;4475;4479.059397526491;4489.730616162975;4574.748388838646;4608.631309495232;3461.9134521636656;3571.982140089283;3578.0697018775304;3581.767185132958;3589.8025608591256;648.4714957309777;651.7588492257801;663.5322097920954;670.805466414744;690.6098054599136;652.4095693397483;676.8172593399754;685.9402223564505;692.4633409107981;720.1825927572244;7666.469273909825;8402.621882015324;8738.126187381338;8818.603162857687;8967.551622418852;629.8393909553034;704.4786857725246;704.6864145455326;734.1850545894054;744.1702501710554;4123.876283711494;4196.076863090116;4295.269804133305;4330.415393921843;4455.084313745121;83669.58165209135;86308.56845715731;87885;89757;90542.09457905337;48959;62060.379396206365;63303.683481582295;77573.61213194011;80009;44197.779011104736;50936;62967.68516157482;66346.66826665933;66791.33208667948;8828.161324674145;9205.849268841395;9228.723138305862;9329.766755830888;9354.348236556887;44359.55640443554;44680.32979505245;45163.54836451593;45729.54270457386;46503.302450462594;38215.42676859905;38474.807625961694;50009.74995125147;60502.394976049676;60822;11496.655100347003;11696.122790790894;11758;12017.699557511132;12222.694432639255;12856.935715321364;13020.869791301966;13068.411921463367;13151.21092734439;13765.242911639956;11062.115030797357;11531.654050378502;11545.191836571359;11574.421278936188;11584.362860042778;11122.110231181325;11297.491612877277;11805.822912656145;11930.642080737245;11957.940210298893;10738.624148154777;11524.250923690268;11536.59621913229;11559.190856639954;11750.647480575597;10022.298439109192;10134.23993200498;10513.9474302628;10556.366618002638;10657.680269591925;9811.705648830546;10034.448105353984;10097.141742951932;10114.443705596263;10156.441395723306 17:32:06 INFO - PROCESS | 9969 | __end_tp_report 17:32:06 INFO - PROCESS | 9969 | __start_cc_report 17:32:06 INFO - PROCESS | 9969 | _x_x_mozilla_cycle_collect,978 17:32:06 INFO - PROCESS | 9969 | __end_cc_report 17:32:06 INFO - PROCESS | 9969 | __startTimestamp1485912726824__endTimestamp 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | ------- Summary: start ------- 17:32:06 INFO - PROCESS | 9969 | Number of tests: 6 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#0] dojo.html Cycles:165 Average:5621.12 Median:5821.04 stddev:638.85 (11.0%) stddev-sans-first:612.42 17:32:06 INFO - PROCESS | 9969 | Values: 3220.5 3259.3 3270.3 3284.2 3302.5 5579.6 5677.1 5678.7 5679.0 5691.7 5634.8 5656.7 5660.8 5712.1 5745.4 5070.5 5091.6 5098.1 5145.1 5165.5 4895.1 4912.1 5071.0 5179.9 5182.5 5114.4 5209.0 5224.9 5226.6 5228.2 5218.4 5219.5 5226.7 5233.1 5264.0 4898.7 4927.8 5111.3 5122.8 5189.8 5491.9 5549.8 5553.4 5557.8 5594.3 6001.6 6010.8 6051.8 6099.0 6105.2 5824.7 6113.9 6142.0 6143.1 6144.2 5478.2 5607.0 5656.4 5665.5 5699.5 6215.9 6218.8 6221.2 6237.5 6240.5 5672.5 5969.0 5974.8 5982.4 5984.3 5822.7 5945.6 6000.2 6007.8 6091.7 6038.9 6043.2 6043.9 6046.5 6069.2 5984.6 6019.8 6033.9 6044.1 6061.8 4548.0 4561.3 4638.9 4639.6 4697.7 4186.2 4210.5 4213.4 4222.5 4247.1 5793.5 5801.9 5814.9 5822.0 5829.5 5817.8 5892.0 6012.7 6080.6 6087.3 5793.4 5820.2 5825.5 5834.2 5838.4 5262.6 5290.9 5297.4 5304.4 5305.1 6050.8 6147.8 6345.5 6381.1 6398.9 6024.2 6077.0 6095.7 6120.7 6160.9 6340.7 6354.3 6361.1 6369.0 6373.1 5654.8 5951.1 6006.1 6015.4 6034.7 5836.9 5973.6 6014.7 6037.6 6122.8 5961.4 5970.3 5977.4 5977.5 5981.7 5964.0 5964.6 5969.2 5972.4 5975.9 5580.6 5687.4 5797.7 5797.9 5821.0 5923.9 5968.9 5970.9 5972.9 5994.6 5552.5 5607.4 5788.7 5809.7 5818.3 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#1] ext.html Cycles:180 Average:61865.71 Median:20913.19 stddev:124879.69 (597.1%) stddev-sans-first:125145.27 17:32:06 INFO - PROCESS | 9969 | Values: 590.2 635.7 646.2 663.2 668.0 35295.0 37601.6 37898.2 37927.0 44903.3 43686.8 48078.8 48155.5 48172.8 48183.5 8862.4 9017.7 9032.5 9051.2 9061.1 8470.9 8688.7 8994.9 9081.5 10653.2 10631.2 10682.5 10684.7 10699.5 10700.4 10960.9 11005.9 11025.5 11031.0 11037.9 10853.6 10945.9 10954.9 10979.1 10983.5 44823.3 45206.0 45244.0 45249.0 45290.8 3731.9 3753.7 3950.4 4070.8 4086.9 32598.8 32802.2 32899.3 32978.2 33219.0 3733.8 3790.5 3811.8 3812.4 3840.2 354160.0 355219.0 355695.0 355869.0 356013.0 38142.4 63581.0 63653.7 63836.4 64017.0 39183.8 41875.6 41963.2 42034.6 42071.6 16825.2 16974.2 16987.2 17001.9 17004.3 13022.4 13035.8 13043.0 13046.4 13069.8 8778.5 9040.5 9086.5 9091.6 9541.3 3593.1 3645.8 3660.5 3703.7 3715.5 1048.2 1069.9 1114.3 1127.4 1169.6 33115.3 33885.7 34131.8 34191.5 34338.8 1127.3 1132.2 1167.7 1169.2 1196.9 16627.2 17893.1 17931.0 19100.1 19321.2 569344.0 572701.0 573416.0 574310.0 576800.0 64216.7 64464.4 64590.7 64627.4 64750.7 1305.2 1346.4 1387.5 1420.5 1447.2 32317.4 33898.8 33925.0 34111.1 34743.3 54384.5 54613.0 55063.7 55158.4 55230.7 450053.0 455284.0 456925.0 456949.0 458098.0 26640.0 27574.9 28903.7 29537.9 29774.9 47755.5 48399.8 48522.8 48860.0 49050.8 40751.6 40901.6 41335.8 42834.1 43060.6 40687.0 40845.4 40951.0 41071.0 42550.1 40993.6 41135.2 41641.8 41958.6 42222.4 35269.6 38014.6 38143.8 38390.4 38907.2 28427.4 28636.6 28664.7 28673.3 28726.6 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#2] jquery.html Cycles:180 Average:29460.60 Median:20661.54 stddev:81719.71 (395.5%) stddev-sans-first:81919.84 17:32:06 INFO - PROCESS | 9969 | Values: 408.3 409.0 424.3 427.7 430.4 18536.6 20153.8 20365.8 20959.3 21259.9 16665.8 19460.4 19717.5 20409.3 20485.9 5555.4 5824.4 5826.3 5831.9 5833.6 5748.1 5760.5 5819.9 5828.1 5865.3 5561.9 5687.5 5694.1 5696.7 5696.8 5591.8 5709.2 5744.0 5820.2 5851.3 5778.3 5786.2 5788.6 5789.5 5792.7 14596.7 14848.9 15017.4 15021.0 15028.4 2160.1 2241.8 2242.3 2421.2 2558.6 10299.5 10441.4 10710.5 10849.9 10897.2 1831.7 1892.8 1903.8 1910.6 1930.9 83927.0 84942.6 85989.0 86616.0 86835.6 10924.1 11412.7 11462.2 11479.2 11637.9 15783.7 16379.6 16407.9 16475.3 16557.9 8017.7 8157.2 8242.7 8395.2 8429.3 7401.9 7651.7 7807.7 8146.1 8189.3 4798.4 4799.4 4817.8 4832.2 4981.0 1943.2 1952.0 1957.4 1989.8 1996.0 940.0 1007.7 1009.9 1018.9 1066.8 19872.6 20211.9 20240.7 20624.3 20698.8 1010.0 1011.1 1013.7 1026.6 1035.3 10348.2 11106.8 11132.2 11192.7 11285.5 484498.0 485026.0 485502.0 506986.0 507460.0 95241.0 98719.5 98886.0 101667.5 103115.5 989.5 1006.7 1008.5 1020.6 1029.3 17410.4 17423.8 17878.5 18099.4 18191.5 43028.8 43118.0 43138.8 43427.6 44241.1 55496.2 59917.7 60056.0 61026.0 61855.0 8762.2 8796.8 8943.4 9054.0 9102.1 13157.5 13365.0 13368.3 13398.0 13835.0 11295.2 11403.5 11407.4 11629.3 11906.4 11558.0 11854.2 11997.9 12030.5 12068.4 11337.5 11345.9 11533.4 11672.9 12018.8 8664.7 8768.6 8818.0 8977.2 9082.0 9896.8 10985.9 11060.6 11166.5 11188.9 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#3] mootools.html Cycles:180 Average:5923.34 Median:4500.48 stddev:3372.02 (74.9%) stddev-sans-first:3364.10 17:32:06 INFO - PROCESS | 9969 | Values: 1368.2 1498.4 1528.8 1693.6 1812.8 7871.3 8621.9 8918.9 8920.0 9180.6 8990.3 9006.2 9053.0 9065.8 9067.5 2456.1 2478.2 2482.3 2483.7 2489.3 2419.3 2493.7 2499.7 2501.8 2503.1 2402.2 2435.2 2492.5 2497.8 2498.2 2353.7 2357.3 2371.6 2372.9 2376.5 2398.6 2433.8 2462.8 2463.9 2465.1 8889.2 9014.6 9090.2 9138.5 9194.5 5404.7 5659.9 5664.9 5667.5 5669.5 3481.9 3574.4 3644.2 3656.0 3720.0 1042.2 1080.8 1086.3 1113.6 1127.8 12626.7 12653.7 12710.4 12726.1 12790.7 4271.0 4482.0 4569.9 4578.6 4597.1 10129.6 10132.2 10132.3 10132.4 10144.3 5389.2 5400.9 5405.5 5415.4 5420.1 4302.7 4519.0 4622.3 5072.4 5167.8 4022.3 4052.7 4153.4 4159.7 4164.2 1228.3 1250.8 1251.6 1252.6 1256.5 963.3 976.3 985.0 987.1 993.6 5971.7 6045.9 6051.1 6156.1 6231.4 435.0 439.0 440.6 1043.3 1081.2 4206.9 4296.3 4321.8 4362.7 4364.0 11021.7 11424.8 11430.9 11439.6 11443.8 10575.6 11328.7 11336.8 11339.8 11358.7 8423.5 8668.8 8697.4 8698.9 8700.4 5890.7 6136.6 6185.2 6221.1 6276.9 10079.3 10241.5 10248.5 10322.2 10600.7 9286.3 9589.6 10675.3 10714.5 10733.0 7506.0 7857.0 7996.2 8058.6 8181.4 8826.9 8846.8 8884.3 8887.0 8890.3 7683.4 7687.0 7765.2 7874.3 7988.3 7593.4 7730.5 7736.2 7739.4 7799.8 6826.7 6906.7 6924.1 6960.5 6965.7 4936.3 5241.2 5258.5 5271.3 5408.2 5019.9 5082.4 5104.6 5130.2 5298.2 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#4] prototype.html Cycles:180 Average:4753.56 Median:5398.65 stddev:1384.33 (25.6%) stddev-sans-first:1347.93 17:32:06 INFO - PROCESS | 9969 | Values: 336.9 341.5 355.4 355.8 357.7 5454.4 5464.8 5484.6 5496.2 5504.4 5147.8 5212.7 5245.7 5302.7 5402.9 4246.9 4249.8 4261.6 4278.2 4289.2 4248.2 4258.9 4268.9 4275.8 4280.4 4092.7 4226.5 4233.5 4250.9 4258.7 4224.6 4226.2 4228.7 4229.4 4233.9 3756.8 3769.5 3783.0 3785.6 3803.4 5059.9 5231.9 5262.9 5286.4 5304.4 4786.0 4791.1 4806.9 4811.5 4827.5 5632.3 5642.3 5663.7 5665.3 5671.7 4013.8 4016.9 4078.2 4131.3 4133.3 5759.5 5793.0 5801.3 5830.8 5856.8 4173.6 4209.5 4220.1 4220.7 4229.3 4121.2 4217.7 4269.7 4270.4 4279.8 4804.2 4807.2 4818.8 4819.2 4835.7 5689.9 5694.8 5700.6 5712.0 5730.4 1392.9 1423.7 1426.9 1428.7 1429.3 969.0 987.5 993.6 998.7 1010.5 5162.7 5308.9 5318.4 5338.7 5357.1 5555.8 5556.1 5556.7 5569.0 5573.2 5261.6 5271.4 5311.4 5322.8 5361.2 2835.0 2975.0 2995.5 3014.8 3026.9 5792.8 5875.6 5885.5 5905.4 5932.6 5511.8 5727.2 5762.0 5791.5 5817.7 5895.0 5897.9 5906.9 5907.5 5911.6 5610.2 5612.1 5643.2 5697.9 5702.6 5446.8 5788.4 5827.2 5836.3 5850.7 6082.5 6119.8 6120.6 6125.5 6146.3 4012.9 4182.1 4220.6 4242.9 4247.6 5555.8 5662.3 5676.8 5792.5 5846.6 5672.3 5682.1 5706.7 5715.3 5733.9 5565.2 5610.4 5715.0 5717.9 5733.8 5601.9 5623.4 5635.5 5658.2 5689.0 5707.5 5708.9 5715.4 5734.3 5734.4 5394.4 5540.4 5603.9 5610.7 5618.0 17:32:06 INFO - PROCESS | 9969 | 17:32:06 INFO - PROCESS | 9969 | [#5] yui.html Cycles:180 Average:16650.11 Median:25555.97 stddev:22178.66 (86.8%) stddev-sans-first:22208.76 17:32:06 INFO - PROCESS | 9969 | Values: 754.2 756.1 788.6 795.8 832.6 13711.6 14033.6 14059.9 14452.2 14548.1 12323.3 12460.1 12470.9 12490.4 12501.8 743.3 762.3 853.2 865.8 883.5 871.7 875.2 878.4 879.1 883.4 924.3 928.9 929.2 929.3 929.4 922.2 923.2 923.9 924.5 924.6 676.2 680.3 680.9 681.2 681.7 12864.3 13118.7 13138.5 13179.5 14218.3 14555.9 15059.6 15125.0 15222.8 15242.2 10786.6 10931.7 11333.4 11382.9 11812.1 3431.9 3436.4 3472.4 3496.3 3544.1 67070.7 67740.7 68381.3 69456.3 70125.6 8847.4 8910.0 8926.5 8945.5 9126.8 19934.0 19990.3 20283.6 20388.6 20526.1 7575.4 7622.9 7751.8 7796.4 8070.0 4475.0 4479.1 4489.7 4574.7 4608.6 3461.9 3572.0 3578.1 3581.8 3589.8 648.5 651.8 663.5 670.8 690.6 652.4 676.8 685.9 692.5 720.2 7666.5 8402.6 8738.1 8818.6 8967.6 629.8 704.5 704.7 734.2 744.2 4123.9 4196.1 4295.3 4330.4 4455.1 83669.6 86308.6 87885.0 89757.0 90542.1 48959.0 62060.4 63303.7 77573.6 80009.0 44197.8 50936.0 62967.7 66346.7 66791.3 8828.2 9205.8 9228.7 9329.8 9354.3 44359.6 44680.3 45163.5 45729.5 46503.3 38215.4 38474.8 50009.7 60502.4 60822.0 11496.7 11696.1 11758.0 12017.7 12222.7 12856.9 13020.9 13068.4 13151.2 13765.2 11062.1 11531.7 11545.2 11574.4 11584.4 11122.1 11297.5 11805.8 11930.6 11957.9 10738.6 11524.3 11536.6 11559.2 11750.6 10022.3 10134.2 10513.9 10556.4 10657.7 9811.7 10034.4 10097.1 10114.4 10156.4 17:32:06 INFO - PROCESS | 9969 | -------- Summary: end -------- 17:32:06 INFO - PROCESS | 9969 | 17:32:07 INFO - TEST-INFO | 9969: exit 0 17:32:07 INFO - TEST-OK | dromaeo_css | took 1115120ms 17:32:07 INFO - TEST-START | kraken 17:32:07 INFO - operating with platform_type : linux_ 17:32:07 INFO - Initialising browser for kraken test... 17:32:07 INFO - TEST-INFO | started process 10276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRr27b/profile http://localhost:42653/getInfo.html) 17:32:11 INFO - PROCESS | 10276 | __metrics Screen width/height:1600/1200 17:32:11 INFO - PROCESS | 10276 | colorDepth:24 17:32:11 INFO - PROCESS | 10276 | Browser inner width/height: 1024/697 17:32:11 INFO - PROCESS | 10276 | __metrics 17:32:12 INFO - PROCESS | 10276 | 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" 17:32:12 INFO - PROCESS | 10276 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:32:13 INFO - PROCESS | 10276 | console.error: PushService: 17:32:13 INFO - PROCESS | 10276 | stateChangeProcessEnqueue: Error transitioning state 17:32:13 INFO - PROCESS | 10276 | UnknownError 17:32:13 INFO - TEST-INFO | 10276: exit 0 17:32:13 INFO - Browser initialized. 17:32:13 INFO - Running cycle 1/1 for kraken test... 17:32:13 INFO - TEST-INFO | started process 10369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuRr27b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:25 INFO - PROCESS | 10369 | RSS: Main: 142135296 17:32:25 INFO - PROCESS | 10369 | 17:32:27 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42653/tests/kraken/driver.html?testName=audio-beat-detection) 17:32:28 INFO - PROCESS | 10369 | RSS: Main: 183758848 17:32:28 INFO - PROCESS | 10369 | 17:32:31 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42653/tests/kraken/driver.html?testName=audio-dft) 17:32:31 INFO - PROCESS | 10369 | RSS: Main: 173449216 17:32:31 INFO - PROCESS | 10369 | 17:32:34 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42653/tests/kraken/driver.html?testName=audio-fft) 17:32:35 INFO - PROCESS | 10369 | RSS: Main: 265023488 17:32:35 INFO - PROCESS | 10369 | 17:32:37 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42653/tests/kraken/driver.html?testName=audio-oscillator) 17:32:37 INFO - PROCESS | 10369 | RSS: Main: 170942464 17:32:37 INFO - PROCESS | 10369 | 17:32:40 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42653/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:32:40 INFO - PROCESS | 10369 | RSS: Main: 173154304 17:32:40 INFO - PROCESS | 10369 | 17:32:43 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42653/tests/kraken/driver.html?testName=imaging-darkroom) 17:32:44 INFO - PROCESS | 10369 | RSS: Main: 212074496 17:32:44 INFO - PROCESS | 10369 | 17:32:47 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42653/tests/kraken/driver.html?testName=imaging-desaturate) 17:32:48 INFO - PROCESS | 10369 | RSS: Main: 211243008 17:32:48 INFO - PROCESS | 10369 | 17:32:50 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42653/tests/kraken/driver.html?testName=json-parse-financial) 17:32:51 INFO - PROCESS | 10369 | RSS: Main: 210120704 17:32:51 INFO - PROCESS | 10369 | 17:32:52 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42653/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:32:53 INFO - PROCESS | 10369 | RSS: Main: 172183552 17:32:53 INFO - PROCESS | 10369 | 17:32:54 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:32:55 INFO - PROCESS | 10369 | RSS: Main: 179326976 17:32:55 INFO - PROCESS | 10369 | 17:32:57 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:32:58 INFO - PROCESS | 10369 | RSS: Main: 188489728 17:32:58 INFO - PROCESS | 10369 | 17:33:00 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:01 INFO - PROCESS | 10369 | RSS: Main: 196374528 17:33:01 INFO - PROCESS | 10369 | 17:33:04 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:04 INFO - PROCESS | 10369 | RSS: Main: 192937984 17:33:04 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | Cycle 1(1): loaded http://localhost:42653/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42653/tests/kraken/driver.html?testName=ai-astar) 17:33:06 INFO - PROCESS | 10369 | RSS: Main: 245358592 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | __start_tp_report 17:33:06 INFO - PROCESS | 10369 | _x_x_mozilla_page_load 17:33:06 INFO - PROCESS | 10369 | _x_x_mozilla_page_load_details 17:33:06 INFO - PROCESS | 10369 | |i|pagename|runs| 17:33:06 INFO - PROCESS | 10369 | |0;ai-astar;102;109;111;113;113;112;110;110;110;111 17:33:06 INFO - PROCESS | 10369 | |1;audio-beat-detection;149;116;115;155;117;121;121;116;144;118 17:33:06 INFO - PROCESS | 10369 | |2;audio-dft;162;161;162;161;161;162;161;161;161;162 17:33:06 INFO - PROCESS | 10369 | |3;audio-fft;74;75;75;110;75;75;76;74;100;75 17:33:06 INFO - PROCESS | 10369 | |4;audio-oscillator;82;81;116;81;82;82;103;81;82;113 17:33:06 INFO - PROCESS | 10369 | |5;imaging-gaussian-blur;117;117;116;117;118;117;118;116;117;117 17:33:06 INFO - PROCESS | 10369 | |6;imaging-darkroom;147;147;146;146;146;147;146;146;147;146 17:33:06 INFO - PROCESS | 10369 | |7;imaging-desaturate;84;84;84;85;85;84;85;84;85;84 17:33:06 INFO - PROCESS | 10369 | |8;json-parse-financial;50;50;49;51;59;52;50;49;49;50 17:33:06 INFO - PROCESS | 10369 | |9;json-stringify-tinderbox;61;59;58;59;58;59;60;60;60;59 17:33:06 INFO - PROCESS | 10369 | |10;stanford-crypto-aes;75;75;75;75;75;74;75;76;78;75 17:33:06 INFO - PROCESS | 10369 | |11;stanford-crypto-ccm;126;132;122;142;132;120;127;125;167;126 17:33:06 INFO - PROCESS | 10369 | |12;stanford-crypto-pbkdf2;162;158;158;159;158;159;159;159;162;157 17:33:06 INFO - PROCESS | 10369 | |13;stanford-crypto-sha256-iterative;63;63;63;62;62;62;65;63;61;65 17:33:06 INFO - PROCESS | 10369 | __end_tp_report 17:33:06 INFO - PROCESS | 10369 | __start_cc_report 17:33:06 INFO - PROCESS | 10369 | _x_x_mozilla_cycle_collect,1586 17:33:06 INFO - PROCESS | 10369 | __end_cc_report 17:33:06 INFO - PROCESS | 10369 | __startTimestamp1485912786624__endTimestamp 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | ------- Summary: start ------- 17:33:06 INFO - PROCESS | 10369 | Number of tests: 14 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:1.41 17:33:06 INFO - PROCESS | 10369 | Values: 102.0 109.0 111.0 113.0 113.0 112.0 110.0 110.0 110.0 111.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:121.00 stddev:15.62 (12.9%) stddev-sans-first:14.44 17:33:06 INFO - PROCESS | 10369 | Values: 149.0 116.0 115.0 155.0 117.0 121.0 121.0 116.0 144.0 118.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 17:33:06 INFO - PROCESS | 10369 | Values: 162.0 161.0 162.0 161.0 161.0 162.0 161.0 161.0 161.0 162.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:12.93 (17.2%) stddev-sans-first:13.47 17:33:06 INFO - PROCESS | 10369 | Values: 74.0 75.0 75.0 110.0 75.0 75.0 76.0 74.0 100.0 75.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.50 stddev:14.42 (17.7%) stddev-sans-first:14.98 17:33:06 INFO - PROCESS | 10369 | Values: 82.0 81.0 116.0 81.0 82.0 82.0 103.0 81.0 82.0 113.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:33:06 INFO - PROCESS | 10369 | Values: 117.0 117.0 116.0 117.0 118.0 117.0 118.0 116.0 117.0 117.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:33:06 INFO - PROCESS | 10369 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 17:33:06 INFO - PROCESS | 10369 | Values: 84.0 84.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 84.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:50.00 stddev:3.00 (6.0%) stddev-sans-first:3.16 17:33:06 INFO - PROCESS | 10369 | Values: 50.0 50.0 49.0 51.0 59.0 52.0 50.0 49.0 49.0 50.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.95 (1.6%) stddev-sans-first:0.78 17:33:06 INFO - PROCESS | 10369 | Values: 61.0 59.0 58.0 59.0 58.0 59.0 60.0 60.0 60.0 59.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:1.06 (1.4%) stddev-sans-first:1.12 17:33:06 INFO - PROCESS | 10369 | Values: 75.0 75.0 75.0 75.0 75.0 74.0 75.0 76.0 78.0 75.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:129.50 stddev:13.80 (10.7%) stddev-sans-first:14.48 17:33:06 INFO - PROCESS | 10369 | Values: 126.0 132.0 122.0 142.0 132.0 120.0 127.0 125.0 167.0 126.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.00 stddev:1.66 (1.0%) stddev-sans-first:1.39 17:33:06 INFO - PROCESS | 10369 | Values: 162.0 158.0 158.0 159.0 158.0 159.0 159.0 159.0 162.0 157.0 17:33:06 INFO - PROCESS | 10369 | 17:33:06 INFO - PROCESS | 10369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.36 17:33:06 INFO - PROCESS | 10369 | Values: 63.0 63.0 63.0 62.0 62.0 62.0 65.0 63.0 61.0 65.0 17:33:06 INFO - PROCESS | 10369 | -------- Summary: end -------- 17:33:06 INFO - PROCESS | 10369 | 17:33:07 INFO - TEST-INFO | 10369: exit 0 17:33:07 INFO - TEST-OK | kraken | took 60059ms 17:33:07 INFO - SUITE-END | took 1175s 17:33:07 INFO - Completed test suite (00:19:35) 17:33:07 INFO - javascript benchmark 17:33:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3220.5169224616307, 3259.348130373926, 3270.3295824356, 3284.1953721338277, 3302.4881143422763, 5579.609427340083, 5677.148427735837, 5678.744456499458, 5679.034564124098, 5691.658500489973, 5634.830955071355, 5656.745446454919, 5660.773569057233, 5712.1431785232235, 5745.396733342991, 5070.492950704927, 5091.592672586203, 5098.082345177866, 5145.073886700392, 5165.483451654842, 4895.069936712031, 4912.091263116335, 5071.0, 5179.922301165486, 5182.507661772144, 5114.43741188469, 5208.973955130219, 5224.869378265555, 5226.634135610509, 5228.241904923784, 5218.399884013311, 5219.530242278194, 5226.660267082647, 5233.058049551079, 5264.0, 4898.730569818658, 4927.802887884481, 5111.284420181178, 5122.795088196468, 5189.844304670866, 5491.890162196773, 5549.833504994856, 5553.389127196006, 5557.777688892439, 5594.328680558318, 6001.5798894077, 6010.819675409744, 6051.848703782397, 6099.0, 6105.236845394325, 5824.708764561755, 6113.908291375633, 6142.0, 6143.109249158847, 6144.170536977495, 5478.150886612581, 5607.0, 5656.4060773619, 5665.461781130868, 5699.5155411790465, 6215.9378406215355, 6218.751249949952, 6221.160143380585, 6237.4698150656795, 6240.469560087353, 5672.489475947102, 5969.044952807617, 5974.761009559569, 5982.40175982407, 5984.3417224105315, 5822.737976791054, 5945.613535120204, 6000.21997140369, 6007.819765406957, 6091.695415229221, 6038.939610603926, 6043.153958445821, 6043.939560604338, 6046.516278697693, 6069.2110025696375, 5984.640921544721, 6019.849503762441, 6033.909491357633, 6044.093385992049, 6061.787837425669, 4548.044910568751, 4561.338605902126, 4638.884027899262, 4639.628829693616, 4697.718136911796, 4186.246475634415, 4210.5157906840495, 4213.410122582841, 4222.472190976128, 4247.108107297502, 5793.478586927196, 5801.8549536261935, 5814.941850581525, 5821.98115329824, 5829.533637309005, 5817.767289308465, 5892.0, 6012.669303188279, 6080.635161890301, 6087.299960504599, 5793.362730099686, 5820.243368362086, 5825.533957283407, 5834.15404766315, 5838.38696936824, 5262.631615786935, 5290.92063619046, 5297.443768404339, 5304.363476382781, 5305.07161246788, 6050.757969681164, 6147.784827531015, 6345.524085693592, 6381.138546296191, 6398.93601064002, 6024.246969128859, 6076.997295446378, 6095.664738439428, 6120.690942950841, 6160.876782464416, 6340.714667839866, 6354.301026887131, 6361.109444677842, 6368.968155159195, 6373.075903993802, 5654.830355089354, 5951.1370851225465, 6006.069059295816, 6015.368386319374, 6034.668093254913, 5836.912446313394, 5973.611715238496, 6014.669193194241, 6037.577369584087, 6122.755089796358, 5961.433663801932, 5970.343262241063, 5977.402259774161, 5977.46202841729, 5981.730822112929, 5963.970180149072, 5964.612300200473, 5969.224000879858, 5972.402759723993, 5975.940240597713, 5580.5535557156145, 5687.374388817144, 5797.6521408713925, 5797.884042319214, 5821.039528477754, 5923.940760592512, 5968.940310596839, 5970.850728731816, 5972.880542389041, 5994.6403215807195, 5552.472515111058, 5607.41122182165, 5788.710564471676, 5809.651420914759, 5818.33089194748], "value": 5578.316906041217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.1825971030124, 635.6694518850198, 646.1696719715166, 663.23396477069, 668.048031555034, 35295.0, 37601.62398376015, 37898.24203515928, 37927.0, 44903.326450103195, 43686.781566092126, 48078.75960620201, 48155.51844481554, 48172.75913620436, 48183.51816481834, 8862.42394244372, 9017.684381046665, 9032.458052516837, 9051.185393314601, 9061.139191776803, 8470.915290847104, 8688.739337819876, 8994.865077023816, 9081.455112693227, 10653.201009924247, 10631.202659800507, 10682.465876706172, 10684.679459616224, 10699.518521666543, 10700.411477368742, 10960.945195274013, 11005.944970275097, 11025.503852326585, 11031.0, 11037.889621103766, 10853.620123295646, 10945.945270273678, 10954.890451095467, 10979.121670266359, 10983.450827458595, 44823.32765008527, 45206.0, 45244.0, 45249.0, 45290.773546132055, 3731.9253614927547, 3753.699704023699, 3950.4469374287623, 4070.7964601769795, 4086.8978275543054, 32598.837005815058, 32802.17994550155, 32899.34201315984, 32978.17554561131, 33219.0, 3733.775973441575, 3790.54513458384, 3811.7522361046445, 3812.370958791796, 3840.1743625120453, 354160.0, 355219.0, 355694.99999999744, 355869.0, 356013.0, 38142.42786358207, 63581.0, 63653.681731591045, 63836.36163638397, 64017.0, 39183.80408097941, 41875.58124418778, 41963.160736785096, 42034.57965420368, 42071.57928420677, 16825.158742063093, 16974.236159372856, 16987.150642467826, 17001.914990425215, 17004.319827207022, 13022.413991370411, 13035.804462933063, 13043.021773367036, 13046.41291141901, 13069.803952940714, 8778.517181555077, 9040.547972601475, 9086.500242486594, 9091.636334546543, 9541.332106752461, 3593.083763640255, 3645.781253124821, 3660.5058317126845, 3703.666669999713, 3715.535558055243, 1048.2190767877828, 1069.9354142627978, 1114.331401159314, 1127.3912087472836, 1169.6140273709655, 33115.337693246, 33885.66114338825, 34131.82934085314, 34191.48712769311, 34338.82830585881, 1127.261643623428, 1132.17351333527, 1167.6963989362657, 1169.2049406403728, 1196.8683444821063, 16627.168641567874, 17893.10534473271, 17931.013928351418, 19100.140493677816, 19321.227150913805, 569344.0, 572701.0, 573416.0, 574310.0, 576800.0, 64216.67891660512, 64464.355356445834, 64590.677046615405, 64627.35372646307, 64750.67624661847, 1305.223392081729, 1346.4210389532595, 1387.5074348606302, 1420.4957240179588, 1447.182341976801, 32317.35365292634, 33898.8305058483, 33925.0, 34111.14722131967, 34743.30513389769, 54384.45615543794, 54613.0, 55063.724681376334, 55158.44841551533, 55230.72384638051, 450053.0, 455284.0, 456925.0, 456949.0, 458098.0, 26640.0, 27574.862125689244, 28903.710962890942, 29537.852310738308, 29774.851125744233, 47755.5224447765, 48399.75800120977, 48522.75738621284, 48860.0, 49050.75474622604, 40751.59248407597, 40901.59098408978, 41335.793321034405, 42834.14331713286, 43060.569394305654, 40687.0, 40845.38731919083, 40951.0, 41071.0, 42550.14899702051, 40993.59006409898, 41135.1772964545, 41641.79179104085, 41958.58041419669, 42222.366664500674, 35269.64730352664, 38014.61985380111, 38143.80928095342, 38390.424143638425, 38907.22185556329, 28427.43145137127, 28636.57045144283, 28664.713352866205, 28673.28316792097, 28726.569101463912], "value": 19964.059093327927, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.2997659014789, 408.99182016359674, 424.295669189146, 427.68137737385655, 430.37165738022486, 18536.62926741466, 20153.798462015395, 20365.796342036592, 20959.266425675105, 21259.893700531476, 16665.750013749774, 19460.41618751436, 19717.507062323413, 20409.285675001378, 20485.897570512127, 5555.416681248461, 5824.388439213885, 5826.300843898717, 5831.854203644901, 5833.591648584601, 5748.137779333113, 5760.51876494955, 5819.9418005819825, 5828.125781132821, 5865.266841644794, 5561.888762224753, 5687.516561092312, 5694.117411801157, 5696.743646535916, 5696.800611978581, 5591.832245032656, 5709.229254050691, 5743.994800909824, 5820.214271073435, 5851.3270973838125, 5778.3066032076, 5786.1610066540115, 5788.594798364116, 5789.536837053068, 5792.739326730307, 14596.70806583873, 14848.925755371154, 15017.399304027826, 15021.02363346379, 15028.398864045424, 2160.092761040367, 2241.820654347648, 2242.316093591454, 2421.225207933462, 2558.6417901493805, 10299.53652085658, 10441.42572158531, 10710.51802668874, 10849.945750271198, 10897.237193396466, 1831.6611426886068, 1892.8485721142276, 1903.8286554210188, 1910.646530391868, 1930.94207173785, 83927.0, 84942.5752871238, 85989.0, 86616.0, 86835.56582217048, 10924.126069914546, 11412.657620271406, 11462.197646164856, 11479.196456247982, 11637.88362116368, 15783.684326313409, 16379.590510237102, 16407.91796041036, 16475.34098636065, 16557.91721041387, 8017.719379821795, 8157.184281571914, 8242.670293188205, 8395.160483951679, 8429.325653947792, 7401.851962960711, 7651.69393224276, 7807.726729564438, 8146.0632027317615, 8189.344852411793, 4798.376211092535, 4799.3760811095035, 4817.8313759018965, 4832.202686556749, 4981.028699403654, 1943.1741509858255, 1951.9804801952082, 1957.4421289932302, 1989.7512810898638, 1995.966131480142, 940.041158018817, 1007.6725064354114, 1009.8737657792776, 1018.9301233704581, 1066.7866426714688, 19872.60254794896, 20211.8989405052, 20240.696389554167, 20624.27815026467, 20698.793012069687, 1009.9545520451597, 1011.0597144655541, 1013.6857574152036, 1026.5637104230673, 1035.2649618770606, 10348.223883208639, 11106.833397499044, 11132.220744547803, 11192.720181995515, 11285.54857805695, 484498.0, 485026.0, 485502.0, 506986.0, 507460.0, 95241.0, 98719.50640246896, 98886.0, 101667.49166254122, 103115.48442257891, 989.5200827598609, 1006.7483129217695, 1008.4604736465956, 1020.6070662794729, 1029.325791606484, 17410.39063632767, 17423.82576174222, 17878.463646090637, 18099.366522171662, 18191.45425637233, 43028.78485607552, 43118.0, 43138.78430607827, 43427.565724342356, 44241.11517769691, 55496.167557487475, 59917.700411499405, 60056.0, 61026.0, 61855.0, 8762.167594078552, 8796.780080498038, 8943.418677786183, 9053.954730226307, 9102.13529714676, 13157.539486118323, 13364.997625177955, 13368.264745438706, 13398.0, 13835.031547791557, 11295.152863535104, 11403.543858245577, 11407.429628518375, 11629.302241865515, 11906.404679765803, 11558.0, 11854.229475084092, 11997.880021199677, 12030.518779249081, 12068.39658017078, 11337.546498139982, 11345.943270283597, 11533.423328833693, 11672.941635291769, 12018.75962480763, 8664.696735614223, 8768.561571921506, 8817.955910220408, 8977.236934860348, 9081.954590227007, 9896.752581185528, 10985.945070274598, 11060.557577697124, 11166.497507612014, 11188.944055279671], "value": 9284.948289378319, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.165419094353, 1498.4380857178558, 1528.8165420149583, 1693.6104695919937, 1812.7915289741675, 7871.330936870366, 8621.913780862189, 8918.866217006742, 8920.0, 9180.586873590688, 8990.280777537797, 9006.234470070052, 9052.954735226314, 9065.773355666111, 9067.546622668873, 2456.0912462388897, 2478.1698131126095, 2482.304954612702, 2483.689538807649, 2489.3278814720015, 2419.322589674894, 2493.7256901740793, 2499.6500489931423, 2501.8123640726926, 2503.0613519930025, 2402.2192787344184, 2435.2329016359877, 2492.464120214154, 2497.8376405533672, 2498.2130628851855, 2353.682252895854, 2357.2574638988835, 2371.6086845670443, 2372.905083796646, 2376.4652953085592, 2398.556267090594, 2433.75662433757, 2462.839915405493, 2463.8521688698734, 2465.1248806673552, 8889.199972002487, 9014.55767077271, 9090.2273306769, 9138.54307284633, 9194.54027298639, 5404.702741349224, 5659.886802263973, 5664.858378540528, 5667.518260947824, 5669.518090962273, 3481.930361392783, 3574.3566158091535, 3644.234710710754, 3656.0, 3719.9628003719886, 1042.2339580408393, 1080.8000519903842, 1086.3101930274254, 1113.5935383584933, 1127.7518945831987, 12626.684332891751, 12653.74692506154, 12710.428030738547, 12726.10917235794, 12790.744185116246, 4271.0, 4482.0, 4569.885752856205, 4578.633709303248, 4597.057603191338, 10129.594816207416, 10132.189424845994, 10132.34139780912, 10132.392056476636, 10144.289899707097, 5389.164679474688, 5400.891982160335, 5405.540529055074, 5415.431379705153, 5420.132778755459, 4302.741835489881, 4518.954810451919, 4622.2835460503675, 5072.391313042459, 5167.793288268503, 4022.2960981828064, 4052.7365721228025, 4153.439285696452, 4159.688023398257, 4164.167166566699, 1228.2875931959443, 1250.781113305168, 1251.6307689231699, 1252.6242127361754, 1256.4534427524056, 963.2823546457794, 976.3214565876648, 984.9950750246203, 987.1214618989105, 993.5677980078689, 5971.6563773151565, 6045.879082418415, 6051.122587224828, 6156.07658851167, 6231.4391704745885, 434.9934750978738, 438.9539098394686, 440.61886468204773, 1043.3114144664485, 1081.1891081688734, 4206.915861682749, 4296.269634162138, 4321.827126914951, 4362.672799540047, 4363.952651363713, 11021.669349919515, 11424.771504569862, 11430.942845285721, 11439.59961401347, 11443.828342574869, 10575.576976920991, 11328.71678208035, 11336.773264534828, 11339.773204535863, 11358.716032099099, 8423.536705481134, 8668.78328041804, 8697.391182617283, 8698.869516957251, 8700.434471759316, 5890.705464726832, 6136.570440069152, 6185.226846644169, 6221.129041934042, 6276.905846412216, 10079.294449388472, 10241.48792560354, 10248.538815753458, 10322.225833062701, 10600.681979540626, 9286.30352723535, 9589.616415343307, 10675.306105103144, 10714.464276786286, 10733.0, 7505.962470187614, 7857.0, 7996.20037996219, 8058.597070146352, 8181.386396020203, 8826.867596986178, 8846.778830529289, 8884.333674974274, 8887.0, 8890.33322500828, 7683.409376380734, 7686.961565192139, 7765.22347765219, 7874.291313781787, 7988.281054705104, 7593.392528597588, 7730.536167829723, 7736.226377362219, 7739.419543534144, 7799.766007019798, 6826.692798824164, 6906.654667266717, 6924.099867017256, 6960.4779641526075, 6965.65171741421, 4936.333594964633, 5241.213817927189, 5258.474152584711, 5271.341082364705, 5408.242846001484, 5019.874503137305, 5082.390113186441, 5104.566111880383, 5130.153524668388, 5298.231756395378], "value": 4705.798143964359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.9444041733114, 341.5338063543263, 355.38873138202314, 355.8292019830481, 357.6888107346609, 5454.409155651068, 5464.781408743655, 5484.61607687462, 5496.203050557671, 5504.4495550444935, 5147.845564633067, 5212.687238765668, 5245.659032162906, 5302.655327403726, 5402.91895621566, 4246.851360202386, 4249.787510624456, 4261.5936740875595, 4278.208531421681, 4289.163613095432, 4248.235317642823, 4258.936115958263, 4268.914621707564, 4275.786210689469, 4280.3793449949735, 4092.6930480213955, 4226.535081141087, 4233.534311225762, 4250.851220207293, 4258.723182993111, 4224.556421575721, 4226.239276930151, 4228.682848786338, 4229.429027081335, 4233.894152646178, 3756.7834977363214, 3769.453429252743, 3782.9621703782886, 3785.62143785622, 3803.4215800442785, 5059.949400505985, 5231.869203269911, 5262.92105618416, 5286.365636123652, 5304.389995150568, 4786.0, 4791.113643975876, 4806.927896081562, 4811.494793046715, 4827.541383568555, 5632.267805185341, 5642.294713160855, 5663.66018038919, 5665.291838520185, 5671.6597004179885, 4013.819378127962, 4016.9397459038137, 4078.1843631273864, 4131.29767939448, 4133.318002529579, 5759.544273435947, 5793.0, 5801.3038435388025, 5830.825075247707, 5856.824295271149, 4173.622704507506, 4209.452771139732, 4220.092680073737, 4220.683448741357, 4229.344451610005, 4121.196366708463, 4217.662586993033, 4269.658427325807, 4270.423492828429, 4279.786010699515, 4804.159272127434, 4807.206810876236, 4818.759062046884, 4819.204831202812, 4835.734034628059, 5689.886202275931, 5694.800681976111, 5700.572457065737, 5712.0, 5730.398308177665, 1392.9094608850392, 1423.7437261293067, 1426.9286535673175, 1428.7499687554637, 1429.349645911108, 968.9709308720609, 987.53585814667, 993.5791817700757, 998.7203582996773, 1010.5351538292321, 5162.664426812245, 5308.867278317995, 5318.414974352818, 5338.652987555796, 5357.11607584752, 5555.777768889199, 5556.138588626861, 5556.722163891789, 5569.0, 5573.247611572467, 5261.605379596469, 5271.367435907716, 5311.3891902431715, 5322.760475778599, 5361.249425080492, 2834.971650283471, 2974.962150926622, 2995.4907665696883, 3014.7940823670706, 3026.8789248429816, 5792.82621521355, 5875.559333050039, 5885.529157667376, 5905.350411454737, 5932.644041357532, 5511.751971161308, 5727.198192253088, 5761.971190144022, 5791.484579847672, 5817.680027598438, 5895.0, 5897.911531327033, 5906.936751384792, 5907.497862681635, 5911.615744976562, 5610.242617246783, 5612.102063669793, 5643.238162847963, 5697.857553561194, 5702.6293290935955, 5446.754896029609, 5788.363280039108, 5827.213326200908, 5836.315294964364, 5850.678212698343, 6082.482988945989, 6119.816405507842, 6120.632762034292, 6125.509959203164, 6146.323904370426, 4012.859549915739, 4182.121754431481, 4220.5568415317175, 4242.8727138185905, 4247.617714405718, 5555.833325000256, 5662.348829884616, 5676.829695109153, 5792.478676919098, 5846.619969701956, 5672.347680016685, 5682.147677848356, 5706.657600543981, 5715.257016587817, 5733.8566535836935, 5565.220869078251, 5610.438956104357, 5715.0, 5717.914231286617, 5733.827985160452, 5601.859953501032, 5623.3814280428305, 5635.549156067423, 5658.151277308437, 5688.975984322861, 5707.5433965281845, 5708.914366284426, 5715.428457154251, 5734.340550836707, 5734.397888221677, 5394.379646340721, 5540.36285827135, 5603.907238088534, 5610.691411972381, 5617.9719101404235], "value": 4315.787782932092, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.2419868032626, 756.1417790807435, 788.585992354014, 795.8050277681969, 832.6253186066269, 13711.588652340433, 14033.578992630211, 14059.859401405984, 14452.20512871793, 14548.127112373251, 12323.322217278046, 12460.12779105463, 12470.875291247108, 12490.375481225925, 12501.812472812915, 743.297583783325, 762.329150347696, 853.2320911179926, 865.8354912566608, 883.5493898111977, 871.6644092024553, 875.2254254984321, 878.3982971664431, 879.1252703559967, 883.3551507399602, 924.2559739409772, 928.8606708993638, 929.2101713543468, 929.2705226397279, 929.3726734454216, 922.1746536849515, 923.187594916476, 923.8798956135727, 924.5007695844304, 924.6070420071476, 676.1716896801428, 680.2755065854849, 680.93190680932, 681.1621705302456, 681.6762038031944, 12864.29246391448, 13118.737625247442, 13138.474461021548, 13179.472821087145, 14218.28908554568, 14555.854441455662, 15059.623509412353, 15124.957818051877, 15222.771658425132, 15242.161681107535, 10786.5685372585, 10931.726706832313, 11333.376664283462, 11382.886171138265, 11812.055035597132, 3431.9485207721655, 3436.381451338758, 3472.4270495368232, 3496.3356962177104, 3544.131687736495, 67070.66464667695, 67740.6612966932, 68381.316186838, 69456.305436946, 70125.64937175333, 8847.380683352103, 8909.955450222707, 8926.464412135292, 8945.46327220369, 9126.771830704285, 19934.0, 19990.300339488047, 20283.59432811365, 20388.592228155652, 20526.07632656534, 7575.431842611826, 7622.885656715153, 7751.7674469766, 7796.376289896794, 8069.9596502018285, 4475.0, 4479.059397526491, 4489.730616162975, 4574.748388838646, 4608.631309495232, 3461.9134521636656, 3571.982140089283, 3578.0697018775304, 3581.767185132958, 3589.8025608591256, 648.4714957309777, 651.7588492257801, 663.5322097920954, 670.805466414744, 690.6098054599136, 652.4095693397483, 676.8172593399754, 685.9402223564505, 692.4633409107981, 720.1825927572244, 7666.469273909825, 8402.621882015324, 8738.126187381338, 8818.603162857687, 8967.551622418852, 629.8393909553034, 704.4786857725246, 704.6864145455326, 734.1850545894054, 744.1702501710554, 4123.876283711494, 4196.076863090116, 4295.269804133305, 4330.415393921843, 4455.084313745121, 83669.58165209135, 86308.56845715731, 87885.0, 89757.0, 90542.09457905337, 48959.0, 62060.379396206365, 63303.683481582295, 77573.61213194011, 80009.0, 44197.779011104736, 50936.0, 62967.68516157482, 66346.66826665933, 66791.33208667948, 8828.161324674145, 9205.849268841395, 9228.723138305862, 9329.766755830888, 9354.348236556887, 44359.55640443554, 44680.32979505245, 45163.54836451593, 45729.54270457386, 46503.302450462594, 38215.42676859905, 38474.807625961694, 50009.74995125147, 60502.394976049676, 60822.0, 11496.655100347003, 11696.122790790894, 11758.0, 12017.699557511132, 12222.694432639255, 12856.935715321364, 13020.869791301966, 13068.411921463367, 13151.21092734439, 13765.242911639956, 11062.115030797357, 11531.654050378502, 11545.191836571359, 11574.421278936188, 11584.362860042778, 11122.110231181325, 11297.491612877277, 11805.822912656145, 11930.642080737245, 11957.940210298893, 10738.624148154777, 11524.250923690268, 11536.59621913229, 11559.190856639954, 11750.647480575597, 10022.298439109192, 10134.23993200498, 10513.9474302628, 10556.366618002638, 10657.680269591925, 9811.705648830546, 10034.448105353984, 10097.141742951932, 10114.443705596263, 10156.441395723306], "value": 6882.490628139298, "unit": "score"}], "name": "dromaeo_css", "value": 7244.396352758768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 111.0, 113.0, 113.0, 112.0, 110.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 115.0, 155.0, 117.0, 121.0, 121.0, 116.0, 144.0, 118.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 75.0, 75.0, 76.0, 74.0, 100.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 116.0, 81.0, 82.0, 82.0, 103.0, 81.0, 82.0, 113.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 49.0, 51.0, 59.0, 52.0, 50.0, 49.0, 49.0, 50.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 58.0, 59.0, 58.0, 59.0, 60.0, 60.0, 60.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 75.0, 75.0, 74.0, 75.0, 76.0, 78.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 132.0, 122.0, 142.0, 132.0, 120.0, 127.0, 125.0, 167.0, 126.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 158.0, 158.0, 159.0, 158.0, 159.0, 159.0, 159.0, 162.0, 157.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 62.0, 62.0, 65.0, 63.0, 61.0, 65.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1457.1, "alertThreshold": 2.0}]} 17:33:07 INFO - Return code: 0 17:33:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:33:07 INFO - # TBPL SUCCESS # 17:33:07 INFO - Running post-action listener: _resource_record_post_action 17:33:07 INFO - [mozharness: 2017-02-01 01:33:07.915058Z] Finished run-tests step (success) 17:33:07 INFO - Running post-run listener: _resource_record_post_run 17:33:07 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 319758336; Read time: 0; Write time: 266484 17:33:07 INFO - TinderboxPrint: CPU usage
13.0% 17:33:07 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:33:07 INFO - TinderboxPrint: I/O write bytes / time
319,758,336 / 266,484 17:33:07 INFO - TinderboxPrint: CPU idle
8,261.6 (87.0%) 17:33:07 INFO - TinderboxPrint: CPU user
1,186.3 (12.5%) 17:33:07 INFO - TinderboxPrint: Swap in / out
0 / 0 17:33:07 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101068800; Read time: 0; Write time: 117004 17:33:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 218689536; Read time: 0; Write time: 149480 17:33:08 INFO - Running post-run listener: _upload_blobber_files 17:33:08 INFO - Blob upload gear active. 17:33:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:33:08 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 17:33:08 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:33:08 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:33:08 INFO - (blobuploader) - INFO - Open directory for files ... 17:33:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:33:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:33:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:09 INFO - (blobuploader) - INFO - Done attempting. 17:33:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:33:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:14 INFO - (blobuploader) - INFO - Done attempting. 17:33:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:33:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:33:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:33:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:33:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:33:15 INFO - (blobuploader) - INFO - Done attempting. 17:33:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:33:15 INFO - Return code: 0 17:33:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:33:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:33:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8a6f938eab7842918ba8275afbc794ea9788abfa751b5a65851637f0c52bf7a371a14b72fead15f61907b409716d795d88c7da0d17846c75a0ddcaa9243977", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8716beeb4b4cae10dd87506e73eca8e918514fd58a1b684bc1e2661727c0df85953311c9f4af5c58e8930fb61ad54ed4adf105da42aa7f3eebaa2b4bde88f055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a2d41019743b3751c029dae27d0ab0fc2bb9a52ea3700a174ac024647609d6469e8267df2d7e36a44d5311f38db7e001a9f6406a233afd21e9f7c5a6f10a41a"} 17:33:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:33:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:33:15 INFO - Contents: 17:33:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8a6f938eab7842918ba8275afbc794ea9788abfa751b5a65851637f0c52bf7a371a14b72fead15f61907b409716d795d88c7da0d17846c75a0ddcaa9243977", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8716beeb4b4cae10dd87506e73eca8e918514fd58a1b684bc1e2661727c0df85953311c9f4af5c58e8930fb61ad54ed4adf105da42aa7f3eebaa2b4bde88f055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a2d41019743b3751c029dae27d0ab0fc2bb9a52ea3700a174ac024647609d6469e8267df2d7e36a44d5311f38db7e001a9f6406a233afd21e9f7c5a6f10a41a"} 17:33:15 INFO - Running post-run listener: copy_logs_to_upload_dir 17:33:15 INFO - Copying logs to upload dir... 17:33:15 INFO - mkdir: /builds/slave/test/build/upload/logs 17:33:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.544868 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-31 17:33:14.518756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 17:33:14.522101) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 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-Beta/sha512/fd8a6f938eab7842918ba8275afbc794ea9788abfa751b5a65851637f0c52bf7a371a14b72fead15f61907b409716d795d88c7da0d17846c75a0ddcaa9243977", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8716beeb4b4cae10dd87506e73eca8e918514fd58a1b684bc1e2661727c0df85953311c9f4af5c58e8930fb61ad54ed4adf105da42aa7f3eebaa2b4bde88f055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a2d41019743b3751c029dae27d0ab0fc2bb9a52ea3700a174ac024647609d6469e8267df2d7e36a44d5311f38db7e001a9f6406a233afd21e9f7c5a6f10a41a"} build_url:https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/PdfWN2RFTa2GMgkm92p7tw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd8a6f938eab7842918ba8275afbc794ea9788abfa751b5a65851637f0c52bf7a371a14b72fead15f61907b409716d795d88c7da0d17846c75a0ddcaa9243977", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8716beeb4b4cae10dd87506e73eca8e918514fd58a1b684bc1e2661727c0df85953311c9f4af5c58e8930fb61ad54ed4adf105da42aa7f3eebaa2b4bde88f055", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a2d41019743b3751c029dae27d0ab0fc2bb9a52ea3700a174ac024647609d6469e8267df2d7e36a44d5311f38db7e001a9f6406a233afd21e9f7c5a6f10a41a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 17:33:14.550032) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:33:14.550668) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1485911559.131725-375991769 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:33:14.636323) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 17:33:14.636879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 17:33:14.637426) ========= ========= Total master_lag: 0.16 =========