builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1476485451.08 results: success (0) buildid: 20161014142435 builduid: f4174ff9c470447a88a3afcbae0aa006 revision: 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.077903) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.078394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.078740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.093744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.094101) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 15:50:51-- 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% 42.6M=0s 2016-10-14 15:50:51 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118370 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.226014) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.226377) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014201 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.275652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:51.276022) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 --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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 15:50:51,487 truncating revision to first 12 chars 2016-10-14 15:50:51,487 Setting DEBUG logging. 2016-10-14 15:50:51,487 attempt 1/10 2016-10-14 15:50:51,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8ed8ed1666c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 15:50:51,796 unpacking tar archive at: mozilla-central-8ed8ed1666c1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.720268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:52.009716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:52.010052) ========= script_repo_revision: 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:52.010430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:52.010708) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 15:50:52.019618) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 15:50:52.019945) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:52 INFO - MultiFileLogger online at 20161014 15:50:52 in /builds/slave/test 15:50:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:50:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:52 INFO - {'append_to_log': False, 15:50:52 INFO - 'base_work_dir': '/builds/slave/test', 15:50:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:50:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:52 INFO - 'branch': 'Firefox-Non-PGO', 15:50:52 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:52 INFO - 'config_files': ('talos/linux_config.py',), 15:50:52 INFO - 'default_actions': ('clobber', 15:50:52 INFO - 'read-buildbot-config', 15:50:52 INFO - 'download-and-extract', 15:50:52 INFO - 'populate-webroot', 15:50:52 INFO - 'create-virtualenv', 15:50:52 INFO - 'install', 15:50:52 INFO - 'run-tests'), 15:50:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:52 INFO - 'download_minidump_stackwalk': True, 15:50:52 INFO - 'download_symbols': 'ondemand', 15:50:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:50:52 INFO - 'tooltool.py': '/tools/tooltool.py', 15:50:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:50:52 INFO - '/tools/misc-python/virtualenv.py')}, 15:50:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:52 INFO - 'installer_path': 'installer.exe', 15:50:52 INFO - 'log_level': 'info', 15:50:52 INFO - 'log_name': 'talos', 15:50:52 INFO - 'log_to_console': True, 15:50:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:52 INFO - 'opt_config_files': (), 15:50:52 INFO - 'pip_index': False, 15:50:52 INFO - 'sps_profile': False, 15:50:52 INFO - 'sps_profile_interval': 0, 15:50:52 INFO - 'suite': 'dromaeojs', 15:50:52 INFO - 'system_bits': '32', 15:50:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:52 INFO - 'title': 'talos-linux64-ix-005', 15:50:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:52 INFO - 'use_talos_json': True, 15:50:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:52 INFO - 'work_dir': 'build'} 15:50:52 INFO - [mozharness: 2016-10-14 22:50:52.332098Z] Running clobber step. 15:50:52 INFO - Running pre-action listener: _resource_record_pre_action 15:50:52 INFO - Running main action method: clobber 15:50:52 INFO - rmtree: /builds/slave/test/build 15:50:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:52 INFO - Running post-action listener: _resource_record_post_action 15:50:52 INFO - [mozharness: 2016-10-14 22:50:52.801553Z] Finished clobber step (success) 15:50:52 INFO - [mozharness: 2016-10-14 22:50:52.801654Z] Running read-buildbot-config step. 15:50:52 INFO - Running pre-action listener: _resource_record_pre_action 15:50:52 INFO - Running main action method: read_buildbot_config 15:50:52 INFO - Using buildbot properties: 15:50:52 INFO - { 15:50:52 INFO - "project": "", 15:50:52 INFO - "product": "firefox", 15:50:52 INFO - "script_repo_revision": "production", 15:50:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:50:52 INFO - "repository": "", 15:50:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:50:52 INFO - "buildid": "20161014142435", 15:50:52 INFO - "pgo_build": "False", 15:50:52 INFO - "basedir": "/builds/slave/test", 15:50:52 INFO - "buildnumber": 678, 15:50:52 INFO - "slavename": "talos-linux64-ix-005", 15:50:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:52 INFO - "platform": "ubuntu64_hw", 15:50:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:50:52 INFO - "branch": "mozilla-central", 15:50:52 INFO - "repo_path": "mozilla-central", 15:50:52 INFO - "revision": "8ed8ed1666c1f8d1255fda90f355b7a9b4369b44", 15:50:52 INFO - "stage_platform": "linux64", 15:50:52 INFO - "builduid": "f4174ff9c470447a88a3afcbae0aa006", 15:50:52 INFO - "slavebuilddir": "test" 15:50:52 INFO - } 15:50:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:50:52 INFO - Running post-action listener: _resource_record_post_action 15:50:52 INFO - [mozharness: 2016-10-14 22:50:52.804061Z] Finished read-buildbot-config step (success) 15:50:52 INFO - [mozharness: 2016-10-14 22:50:52.804149Z] Running download-and-extract step. 15:50:52 INFO - Running pre-action listener: _resource_record_pre_action 15:50:52 INFO - Running main action method: download_and_extract 15:50:52 INFO - mkdir: /builds/slave/test/build/tests 15:50:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:52 INFO - trying https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:50:52 INFO - Downloading https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:50:53 INFO - Downloaded 1361 bytes. 15:50:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:50:53 INFO - Using the following test package requirements: 15:50:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:50:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:50:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'jsshell-linux-x86_64.zip'], 15:50:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:50:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:50:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:50:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:50:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:50:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:50:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:50:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:50:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:50:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:53 INFO - Fetch https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:53 INFO - Http code: 200 15:50:53 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 15:50:53 INFO - x-amz-cf-id: Q_YaScLsZuwV_vmklj62DU_Rhc-VThBcPwkm-Tt_rFbp2bHLlQx1Vw== 15:50:53 INFO - x-amz-version-id: n2KAwHnf2Z6C8ALQlUi0j.PT83OEMR1e 15:50:54 INFO - Expected file size: 20553602 15:50:54 INFO - Obtained file size: 20553602 15:50:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:50:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:50:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:50:58 INFO - Fetch https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:50:58 INFO - Http code: 200 15:50:58 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 15:50:58 INFO - x-amz-cf-id: skgrv0egJy7lpsTq4BZQNerQkvSxdcFg9uxG_SWFH9Q0J7aA1KMn5A== 15:50:58 INFO - x-amz-version-id: n2KAwHnf2Z6C8ALQlUi0j.PT83OEMR1e 15:50:59 INFO - Expected file size: 20553602 15:50:59 INFO - Obtained file size: 20553602 15:51:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:51:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:03 INFO - Fetch https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:51:04 INFO - Http code: 200 15:51:04 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 15:51:04 INFO - x-amz-cf-id: cB6mKoTatjC4nX-jZXLQUHRac4VMZDBxbNFCpbHUTPGEMuE6ppntFA== 15:51:04 INFO - x-amz-version-id: QkRM6J7c00eeV0tUD5ZbOKM4Wr7LvtrW 15:51:04 INFO - Expected file size: 14409006 15:51:04 INFO - Obtained file size: 14409006 15:51: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')]} 15:51:04 INFO - trying https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:04 INFO - Downloading https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:05 INFO - Downloaded 55652579 bytes. 15:51:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:05 INFO - mkdir: /builds/slave/test/properties 15:51:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:51:05 INFO - Writing to file /builds/slave/test/properties/build_url 15:51:05 INFO - Contents: 15:51:05 INFO - build_url:https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:51:06 INFO - Running post-action listener: _resource_record_post_action 15:51:06 INFO - Running post-action listener: set_extra_try_arguments 15:51:06 INFO - [mozharness: 2016-10-14 22:51:06.352898Z] Finished download-and-extract step (success) 15:51:06 INFO - [mozharness: 2016-10-14 22:51:06.353122Z] Running populate-webroot step. 15:51:06 INFO - Running pre-action listener: _resource_record_pre_action 15:51:06 INFO - Running main action method: populate_webroot 15:51:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:06 INFO - '--tppagecycles', 15:51:06 INFO - '7'], 15:51:06 INFO - 'tests': ['tsvgm']}}, 15:51:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:51:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:51:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['damp', 'tps']}, 15:51:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'tests': ['damp', 'tps']}, 15:51:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['dromaeo_dom']}, 15:51:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['basic_compositor_video']}, 15:51:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:51:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'other-e10s': {'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['a11yr', 15:51:06 INFO - 'ts_paint', 15:51:06 INFO - 'tpaint', 15:51:06 INFO - 'sessionrestore', 15:51:06 INFO - 'sessionrestore_no_auto_restore', 15:51:06 INFO - 'tabpaint']}, 15:51:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['tsvgx', 15:51:06 INFO - 'tsvgr_opacity', 15:51:06 INFO - 'tart', 15:51:06 INFO - 'tscrollx', 15:51:06 INFO - 'cart']}, 15:51:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:51:06 INFO - 'tsvgr_opacity', 15:51:06 INFO - 'tart', 15:51:06 INFO - 'tscrollx', 15:51:06 INFO - 'cart']}, 15:51:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'talos_options': ['--disable-e10s'], 15:51:06 INFO - 'tests': ['tp5o']}, 15:51:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'tests': ['tp5o']}, 15:51:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'talos_options': ['--disable-e10s', 15:51:06 INFO - '--xperf_path', 15:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:06 INFO - 'tests': ['tp5n']}, 15:51:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:06 INFO - 'talos_options': ['--xperf_path', 15:51:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:06 INFO - 'tests': ['tp5n']}}, 15:51:06 INFO - 'talos.zip': {'path': '', 15:51:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:06 INFO - Running post-action listener: _resource_record_post_action 15:51:06 INFO - [mozharness: 2016-10-14 22:51:06.369040Z] Finished populate-webroot step (success) 15:51:06 INFO - [mozharness: 2016-10-14 22:51:06.369128Z] Running create-virtualenv step. 15:51:06 INFO - Running pre-action listener: _resource_record_pre_action 15:51:06 INFO - Running main action method: create_virtualenv 15:51:06 INFO - Creating virtualenv /builds/slave/test/build/venv 15:51:06 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 15:51:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:51:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:06 INFO - Using real prefix '/usr' 15:51:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:51:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:08 INFO - Installing pip.................done. 15:51:08 INFO - Return code: 0 15:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:51:09 INFO - Reading from file tmpfile_stdout 15:51:09 INFO - Output received: 15:51:09 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) 15:51:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:51:09 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')]} 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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')]} 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:09 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 15:51:09 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 15:51:09 INFO - Using env: {'DISPLAY': ':0', 15:51:09 INFO - 'HOME': '/home/cltbld', 15:51:09 INFO - 'LANG': 'en_US.UTF-8', 15:51:09 INFO - 'LANGUAGE': 'en_US:en', 15:51:09 INFO - 'LOGNAME': 'cltbld', 15:51:09 INFO - 'MAIL': '/var/mail/cltbld', 15:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:09 INFO - 'MOZ_NO_REMOTE': '1', 15:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:09 INFO - 'NO_EM_RESTART': '1', 15:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:09 INFO - 'PWD': '/builds/slave/test', 15:51:09 INFO - 'SHELL': '/bin/bash', 15:51:09 INFO - 'SHLVL': '1', 15:51:09 INFO - 'TERM': 'linux', 15:51:09 INFO - 'TMOUT': '86400', 15:51:09 INFO - 'USER': 'cltbld', 15:51:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:09 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 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 15:51:09 INFO - Cleaning up... 15:51:09 INFO - Return code: 0 15:51:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:51:09 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')]} 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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')]} 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:09 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:09 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 15:51:09 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 15:51:09 INFO - Using env: {'DISPLAY': ':0', 15:51:09 INFO - 'HOME': '/home/cltbld', 15:51:09 INFO - 'LANG': 'en_US.UTF-8', 15:51:09 INFO - 'LANGUAGE': 'en_US:en', 15:51:09 INFO - 'LOGNAME': 'cltbld', 15:51:09 INFO - 'MAIL': '/var/mail/cltbld', 15:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:09 INFO - 'MOZ_NO_REMOTE': '1', 15:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:09 INFO - 'NO_EM_RESTART': '1', 15:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:09 INFO - 'PWD': '/builds/slave/test', 15:51:09 INFO - 'SHELL': '/bin/bash', 15:51:09 INFO - 'SHLVL': '1', 15:51:09 INFO - 'TERM': 'linux', 15:51:09 INFO - 'TMOUT': '86400', 15:51:09 INFO - 'USER': 'cltbld', 15:51:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:09 INFO - '_': '/tools/buildbot/bin/python'} 15:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:09 INFO - Downloading/unpacking psutil>=3.1.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:11 INFO - Installing collected packages: psutil 15:51:11 INFO - Running setup.py install for psutil 15:51:11 INFO - building 'psutil._psutil_linux' extension 15:51:11 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 15:51:11 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 15:51:11 INFO - building 'psutil._psutil_posix' extension 15:51:11 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 15:51:12 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 15:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:12 INFO - Successfully installed psutil 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:51:12 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')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 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')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:12 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:12 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 15:51:12 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 15:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:12 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 15:51:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:51:14 INFO - Installing collected packages: mozsystemmonitor 15:51:14 INFO - Running setup.py install for mozsystemmonitor 15:51:14 INFO - Successfully installed mozsystemmonitor 15:51:14 INFO - Cleaning up... 15:51:14 INFO - Return code: 0 15:51:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:51:14 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')]} 15:51:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:14 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')]} 15:51:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:14 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:14 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 15:51:14 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 15:51:14 INFO - Using env: {'DISPLAY': ':0', 15:51:14 INFO - 'HOME': '/home/cltbld', 15:51:14 INFO - 'LANG': 'en_US.UTF-8', 15:51:14 INFO - 'LANGUAGE': 'en_US:en', 15:51:14 INFO - 'LOGNAME': 'cltbld', 15:51:14 INFO - 'MAIL': '/var/mail/cltbld', 15:51:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:14 INFO - 'MOZ_NO_REMOTE': '1', 15:51:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:14 INFO - 'NO_EM_RESTART': '1', 15:51:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:14 INFO - 'PWD': '/builds/slave/test', 15:51:14 INFO - 'SHELL': '/bin/bash', 15:51:14 INFO - 'SHLVL': '1', 15:51:14 INFO - 'TERM': 'linux', 15:51:14 INFO - 'TMOUT': '86400', 15:51:14 INFO - 'USER': 'cltbld', 15:51:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:14 INFO - '_': '/tools/buildbot/bin/python'} 15:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:14 INFO - Downloading/unpacking jsonschema==2.5.1 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:14 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 15:51:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:16 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 15:51:16 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 15:51:16 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 15:51:16 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 15:51:16 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 15:51:16 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 15:51:16 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:16 INFO - warning: no files found matching '*.txt' 15:51:16 INFO - no previously-included directories found matching 'build' 15:51:16 INFO - no previously-included directories found matching 'dist' 15:51:16 INFO - no previously-included directories found matching '.git*' 15:51:16 INFO - Installing collected packages: jsonschema, functools32 15:51:17 INFO - Running setup.py install for functools32 15:51:17 INFO - warning: no files found matching '*.txt' 15:51:17 INFO - no previously-included directories found matching 'build' 15:51:17 INFO - no previously-included directories found matching 'dist' 15:51:17 INFO - no previously-included directories found matching '.git*' 15:51:17 INFO - Successfully installed jsonschema functools32 15:51:17 INFO - Cleaning up... 15:51:17 INFO - Return code: 0 15:51:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:17 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 15:51:17 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 15:51:17 INFO - Using env: {'DISPLAY': ':0', 15:51:17 INFO - 'HOME': '/home/cltbld', 15:51:17 INFO - 'LANG': 'en_US.UTF-8', 15:51:17 INFO - 'LANGUAGE': 'en_US:en', 15:51:17 INFO - 'LOGNAME': 'cltbld', 15:51:17 INFO - 'MAIL': '/var/mail/cltbld', 15:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:17 INFO - 'MOZ_NO_REMOTE': '1', 15:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:17 INFO - 'NO_EM_RESTART': '1', 15:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:17 INFO - 'PWD': '/builds/slave/test', 15:51:17 INFO - 'SHELL': '/bin/bash', 15:51:17 INFO - 'SHLVL': '1', 15:51:17 INFO - 'TERM': 'linux', 15:51:17 INFO - 'TMOUT': '86400', 15:51:17 INFO - 'USER': 'cltbld', 15:51:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:17 INFO - '_': '/tools/buildbot/bin/python'} 15:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:51:17 INFO - Cleaning up... 15:51:17 INFO - Return code: 0 15:51:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51: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')]} 15:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:17 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:17 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 15:51:17 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 15:51:17 INFO - Using env: {'DISPLAY': ':0', 15:51:17 INFO - 'HOME': '/home/cltbld', 15:51:17 INFO - 'LANG': 'en_US.UTF-8', 15:51:17 INFO - 'LANGUAGE': 'en_US:en', 15:51:17 INFO - 'LOGNAME': 'cltbld', 15:51:17 INFO - 'MAIL': '/var/mail/cltbld', 15:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:17 INFO - 'MOZ_NO_REMOTE': '1', 15:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:17 INFO - 'NO_EM_RESTART': '1', 15:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:17 INFO - 'PWD': '/builds/slave/test', 15:51:17 INFO - 'SHELL': '/bin/bash', 15:51:17 INFO - 'SHLVL': '1', 15:51:17 INFO - 'TERM': 'linux', 15:51:17 INFO - 'TMOUT': '86400', 15:51:17 INFO - 'USER': 'cltbld', 15:51:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:17 INFO - '_': '/tools/buildbot/bin/python'} 15:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:17 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:17 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 15:51:19 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 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 15:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 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 15:51:20 INFO - Downloading docopt-0.6.1.tar.gz 15:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:20 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:20 INFO - Running setup.py install for blobuploader 15:51:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:20 INFO - Running setup.py install for requests 15:51:20 INFO - Running setup.py install for docopt 15:51:20 INFO - Successfully installed blobuploader requests docopt 15:51:20 INFO - Cleaning up... 15:51:20 INFO - Return code: 0 15:51:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:20 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')]} 15:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:20 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')]} 15:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:20 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:20 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 15:51:20 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 15:51:20 INFO - Using env: {'DISPLAY': ':0', 15:51:20 INFO - 'HOME': '/home/cltbld', 15:51:20 INFO - 'LANG': 'en_US.UTF-8', 15:51:20 INFO - 'LANGUAGE': 'en_US:en', 15:51:20 INFO - 'LOGNAME': 'cltbld', 15:51:20 INFO - 'MAIL': '/var/mail/cltbld', 15:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:20 INFO - 'MOZ_NO_REMOTE': '1', 15:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:20 INFO - 'NO_EM_RESTART': '1', 15:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:20 INFO - 'PWD': '/builds/slave/test', 15:51:20 INFO - 'SHELL': '/bin/bash', 15:51:20 INFO - 'SHLVL': '1', 15:51:20 INFO - 'TERM': 'linux', 15:51:20 INFO - 'TMOUT': '86400', 15:51:20 INFO - 'USER': 'cltbld', 15:51:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:20 INFO - '_': '/tools/buildbot/bin/python'} 15:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:21 INFO - Running setup.py (path:/tmp/pip-5N7DKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:21 INFO - Running setup.py (path:/tmp/pip-8lR2ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:21 INFO - Running setup.py (path:/tmp/pip-fyA5WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:21 INFO - Running setup.py (path:/tmp/pip-vi2Z3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:21 INFO - Running setup.py (path:/tmp/pip-m1aGIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:21 INFO - Running setup.py (path:/tmp/pip-wYwE9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:21 INFO - Running setup.py (path:/tmp/pip-N_rqXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:21 INFO - Running setup.py (path:/tmp/pip-SbM7eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:21 INFO - Running setup.py (path:/tmp/pip-ogl8WN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:21 INFO - Running setup.py (path:/tmp/pip-84qJ4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:21 INFO - Running setup.py (path:/tmp/pip-_f1GVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:21 INFO - Running setup.py (path:/tmp/pip-xg9FT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:22 INFO - Running setup.py (path:/tmp/pip-WrOlfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:22 INFO - Running setup.py (path:/tmp/pip-aiVu_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:22 INFO - Running setup.py (path:/tmp/pip-stzQSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:22 INFO - Running setup.py (path:/tmp/pip-Go2ghy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:22 INFO - Running setup.py (path:/tmp/pip-mVltJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:22 INFO - Running setup.py install for manifestparser 15:51:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Running setup.py install for mozcrash 15:51:22 INFO - Running setup.py install for mozdebug 15:51:22 INFO - Running setup.py install for mozdevice 15:51:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Running setup.py install for mozfile 15:51:22 INFO - Running setup.py install for mozhttpd 15:51:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:22 INFO - Running setup.py install for mozinfo 15:51:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozInstall 15:51:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozleak 15:51:23 INFO - Running setup.py install for mozlog 15:51:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for moznetwork 15:51:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozprocess 15:51:23 INFO - Running setup.py install for mozprofile 15:51:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozrunner 15:51:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:23 INFO - Running setup.py install for mozscreenshot 15:51:23 INFO - Running setup.py install for moztest 15:51:24 INFO - Running setup.py install for mozversion 15:51:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:24 INFO - Cleaning up... 15:51:24 INFO - Return code: 0 15:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:24 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')]} 15:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 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')]} 15:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:24 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:24 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 15:51:24 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 15:51:24 INFO - Using env: {'DISPLAY': ':0', 15:51:24 INFO - 'HOME': '/home/cltbld', 15:51:24 INFO - 'LANG': 'en_US.UTF-8', 15:51:24 INFO - 'LANGUAGE': 'en_US:en', 15:51:24 INFO - 'LOGNAME': 'cltbld', 15:51:24 INFO - 'MAIL': '/var/mail/cltbld', 15:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:24 INFO - 'MOZ_NO_REMOTE': '1', 15:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:24 INFO - 'NO_EM_RESTART': '1', 15:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:24 INFO - 'PWD': '/builds/slave/test', 15:51:24 INFO - 'SHELL': '/bin/bash', 15:51:24 INFO - 'SHLVL': '1', 15:51:24 INFO - 'TERM': 'linux', 15:51:24 INFO - 'TMOUT': '86400', 15:51:24 INFO - 'USER': 'cltbld', 15:51:24 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:24 INFO - '_': '/tools/buildbot/bin/python'} 15:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:24 INFO - Running setup.py (path:/tmp/pip-TeFo8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:24 INFO - Running setup.py (path:/tmp/pip-6vskVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:24 INFO - Running setup.py (path:/tmp/pip-UneKuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:24 INFO - Running setup.py (path:/tmp/pip-ce7c27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:24 INFO - Running setup.py (path:/tmp/pip-6bL_kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:24 INFO - Running setup.py (path:/tmp/pip-1YwxwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:24 INFO - Running setup.py (path:/tmp/pip-qePTpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:24 INFO - Running setup.py (path:/tmp/pip-n4kNvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:24 INFO - Running setup.py (path:/tmp/pip-GQJnyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:24 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)) 15:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:25 INFO - Running setup.py (path:/tmp/pip-seueia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:25 INFO - Running setup.py (path:/tmp/pip-E3Mc7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:25 INFO - Running setup.py (path:/tmp/pip-izhCzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:25 INFO - Running setup.py (path:/tmp/pip-vWxqxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:25 INFO - Running setup.py (path:/tmp/pip-yCJEID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:25 INFO - Running setup.py (path:/tmp/pip-AJv4Ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:25 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:25 INFO - Running setup.py (path:/tmp/pip-WsK_WE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 15:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:25 INFO - Running setup.py (path:/tmp/pip-CcHeeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:25 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)) 15:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:25 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)) 15:51:25 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)) 15:51:25 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)) 15:51:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:25 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 15:51:27 INFO - Downloading blessings-1.6.tar.gz 15:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:27 INFO - Installing collected packages: blessings 15:51:27 INFO - Running setup.py install for blessings 15:51:27 INFO - Successfully installed blessings 15:51:27 INFO - Cleaning up... 15:51:27 INFO - Return code: 0 15:51:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:27 INFO - Reading from file tmpfile_stdout 15:51:27 INFO - Current package versions: 15:51:27 INFO - argparse == 1.2.1 15:51:27 INFO - blessings == 1.6 15:51:27 INFO - blobuploader == 1.2.4 15:51:27 INFO - docopt == 0.6.1 15:51:27 INFO - functools32 == 3.2.3-2 15:51:27 INFO - jsonschema == 2.5.1 15:51:27 INFO - manifestparser == 1.1 15:51:27 INFO - mozInstall == 1.12 15:51:27 INFO - mozcrash == 0.17 15:51:27 INFO - mozdebug == 0.1 15:51:27 INFO - mozdevice == 0.48 15:51:27 INFO - mozfile == 1.2 15:51:27 INFO - mozhttpd == 0.7 15:51:27 INFO - mozinfo == 0.9 15:51:27 INFO - mozleak == 0.1 15:51:27 INFO - mozlog == 3.4 15:51:27 INFO - moznetwork == 0.27 15:51:27 INFO - mozprocess == 0.23 15:51:27 INFO - mozprofile == 0.28 15:51:27 INFO - mozrunner == 6.12 15:51:27 INFO - mozscreenshot == 0.1 15:51:27 INFO - mozsystemmonitor == 0.3 15:51:27 INFO - moztest == 0.7 15:51:27 INFO - mozversion == 1.4 15:51:27 INFO - psutil == 3.1.1 15:51:27 INFO - requests == 1.2.3 15:51:27 INFO - wsgiref == 0.1.2 15:51:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:27 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')]} 15:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:27 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')]} 15:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:28 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 15:51:28 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 15:51:28 INFO - Using env: {'DISPLAY': ':0', 15:51:28 INFO - 'HOME': '/home/cltbld', 15:51:28 INFO - 'LANG': 'en_US.UTF-8', 15:51:28 INFO - 'LANGUAGE': 'en_US:en', 15:51:28 INFO - 'LOGNAME': 'cltbld', 15:51:28 INFO - 'MAIL': '/var/mail/cltbld', 15:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:28 INFO - 'MOZ_NO_REMOTE': '1', 15:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:28 INFO - 'NO_EM_RESTART': '1', 15:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:28 INFO - 'PWD': '/builds/slave/test', 15:51:28 INFO - 'SHELL': '/bin/bash', 15:51:28 INFO - 'SHLVL': '1', 15:51:28 INFO - 'TERM': 'linux', 15:51:28 INFO - 'TMOUT': '86400', 15:51:28 INFO - 'USER': 'cltbld', 15:51:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:28 INFO - '_': '/tools/buildbot/bin/python'} 15:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 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)) 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:28 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')]} 15:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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')]} 15:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:28 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 0x7f1b7b4fcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2413ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', '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 15:51:28 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 15:51:28 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 15:51:28 INFO - Using env: {'DISPLAY': ':0', 15:51:28 INFO - 'HOME': '/home/cltbld', 15:51:28 INFO - 'LANG': 'en_US.UTF-8', 15:51:28 INFO - 'LANGUAGE': 'en_US:en', 15:51:28 INFO - 'LOGNAME': 'cltbld', 15:51:28 INFO - 'MAIL': '/var/mail/cltbld', 15:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:28 INFO - 'MOZ_NO_REMOTE': '1', 15:51:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:28 INFO - 'NO_EM_RESTART': '1', 15:51:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:28 INFO - 'PWD': '/builds/slave/test', 15:51:28 INFO - 'SHELL': '/bin/bash', 15:51:28 INFO - 'SHLVL': '1', 15:51:28 INFO - 'TERM': 'linux', 15:51:28 INFO - 'TMOUT': '86400', 15:51:28 INFO - 'USER': 'cltbld', 15:51:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:28 INFO - '_': '/tools/buildbot/bin/python'} 15:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:28 INFO - Cleaning up... 15:51:28 INFO - Return code: 0 15:51:28 INFO - Running post-action listener: _resource_record_post_action 15:51:28 INFO - Running post-action listener: _start_resource_monitoring 15:51:28 INFO - Starting resource monitoring. 15:51:28 INFO - [mozharness: 2016-10-14 22:51:28.493046Z] Finished create-virtualenv step (success) 15:51:28 INFO - [mozharness: 2016-10-14 22:51:28.493541Z] Running install step. 15:51:28 INFO - Running pre-action listener: _resource_record_pre_action 15:51:28 INFO - Running main action method: install 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:28 INFO - Reading from file tmpfile_stdout 15:51:28 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:28 INFO - Reading from file tmpfile_stdout 15:51:28 INFO - Output received: 15:51:28 INFO - Usage: mozinstall [options] installer 15:51:28 INFO - Options: 15:51:28 INFO - -h, --help show this help message and exit 15:51:28 INFO - -d DEST, --destination=DEST 15:51:28 INFO - Directory to install application into. [default: 15:51:28 INFO - "/builds/slave/test"] 15:51:28 INFO - --app=APP Application being installed. [default: firefox] 15:51:28 INFO - mkdir: /builds/slave/test/build/application 15:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:51:44 INFO - Reading from file tmpfile_stdout 15:51:44 INFO - Output received: 15:51:44 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:44 INFO - Running post-action listener: _resource_record_post_action 15:51:44 INFO - [mozharness: 2016-10-14 22:51:44.861368Z] Finished install step (success) 15:51:44 INFO - [mozharness: 2016-10-14 22:51:44.861617Z] Running run-tests step. 15:51:44 INFO - Running pre-action listener: _resource_record_pre_action 15:51:44 INFO - Running main action method: run_tests 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:44 INFO - Python 2.7.3 15:51:44 INFO - Return code: 0 15:51:44 INFO - grabbing minidump binary from tooltool 15:51:44 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')]} 15:51:44 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 0x2410f60>, '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 0x2411d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24121d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:44 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 15:51:44 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 15:51:44 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 15:51:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:44 INFO - Return code: 0 15:51:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 15:51:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 15:51:44 INFO - Using env: {'DISPLAY': ':0', 15:51:44 INFO - 'HOME': '/home/cltbld', 15:51:44 INFO - 'LANG': 'en_US.UTF-8', 15:51:44 INFO - 'LANGUAGE': 'en_US:en', 15:51:44 INFO - 'LOGNAME': 'cltbld', 15:51:44 INFO - 'MAIL': '/var/mail/cltbld', 15:51:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:44 INFO - 'MOZ_NO_REMOTE': '1', 15:51:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:44 INFO - 'NO_EM_RESTART': '1', 15:51:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:44 INFO - 'PWD': '/builds/slave/test', 15:51:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:44 INFO - 'SHELL': '/bin/bash', 15:51:44 INFO - 'SHLVL': '1', 15:51:44 INFO - 'TERM': 'linux', 15:51:44 INFO - 'TMOUT': '86400', 15:51:44 INFO - 'USER': 'cltbld', 15:51:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223', 15:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:44 INFO - '_': '/tools/buildbot/bin/python'} 15:51:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 15:51:45 INFO - mozversion application_buildid: 20161014142435 15:51:45 INFO - mozversion application_changeset: 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 15:51:45 INFO - mozversion application_display_name: Nightly 15:51:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:45 INFO - mozversion application_name: Firefox 15:51:45 INFO - mozversion application_remotingname: firefox 15:51:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:51:45 INFO - mozversion application_vendor: Mozilla 15:51:45 INFO - mozversion application_version: 52.0a1 15:51:45 INFO - mozversion platform_buildid: 20161014142435 15:51:45 INFO - mozversion platform_changeset: 8ed8ed1666c1f8d1255fda90f355b7a9b4369b44 15:51:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:51:45 INFO - mozversion platform_version: 52.0a1 15:51:45 INFO - using testdate: 1476485505 15:51:45 INFO - actual date: 1476485505 15:51:45 INFO - starting webserver on 'localhost:60372' 15:51:45 INFO - SUITE-START | Running 2 tests 15:51:45 INFO - TEST-START | dromaeo_css 15:51:45 INFO - operating with platform_type : linux_ 15:51:45 INFO - Initialising browser for dromaeo_css test... 15:51:45 INFO - TEST-INFO | started process 22073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgcaxD0/profile http://localhost:60372/getInfo.html) 15:51:49 INFO - PROCESS | 22073 | __metrics Screen width/height:1600/1200 15:51:49 INFO - PROCESS | 22073 | colorDepth:24 15:51:49 INFO - PROCESS | 22073 | Browser inner width/height: 1024/697 15:51:49 INFO - PROCESS | 22073 | __metrics 15:51:49 INFO - PROCESS | 22073 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:51:49 INFO - PROCESS | 22073 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:50 INFO - PROCESS | 22073 | console.error: PushService: 15:51:50 INFO - PROCESS | 22073 | stateChangeProcessEnqueue: Error transitioning state 15:51:50 INFO - PROCESS | 22073 | UnknownError 15:51:51 INFO - TEST-INFO | 22073: exit 0 15:51:51 INFO - Browser initialized. 15:51:51 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:51 INFO - TEST-INFO | started process 22155 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgcaxD0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:03 INFO - PROCESS | 22155 | RSS: Main: 174137344 15:52:03 INFO - PROCESS | 22155 | 15:52:55 INFO - PROCESS | 22155 | 1476485575160 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:55:08 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60372/tests/dromaeo/cssquery-ext.html) 15:55:10 INFO - PROCESS | 22155 | RSS: Main: 329912320 15:55:10 INFO - PROCESS | 22155 | 15:58:12 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-ext.html (next: http://localhost:60372/tests/dromaeo/cssquery-jquery.html) 15:58:13 INFO - PROCESS | 22155 | RSS: Main: 283029504 15:58:13 INFO - PROCESS | 22155 | 16:01:15 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60372/tests/dromaeo/cssquery-mootools.html) 16:01:16 INFO - PROCESS | 22155 | RSS: Main: 264810496 16:01:16 INFO - PROCESS | 22155 | 16:04:18 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60372/tests/dromaeo/cssquery-prototype.html) 16:04:18 INFO - PROCESS | 22155 | RSS: Main: 218992640 16:04:18 INFO - PROCESS | 22155 | 16:07:22 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60372/tests/dromaeo/cssquery-yui.html) 16:07:22 INFO - PROCESS | 22155 | RSS: Main: 220913664 16:07:22 INFO - PROCESS | 22155 | 16:10:25 INFO - PROCESS | 22155 | Cycle 1(1): loaded http://localhost:60372/tests/dromaeo/cssquery-yui.html (next: http://localhost:60372/tests/dromaeo/cssquery-dojo.html) 16:10:26 INFO - PROCESS | 22155 | RSS: Main: 309870592 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | __start_tp_report 16:10:26 INFO - PROCESS | 22155 | _x_x_mozilla_page_load 16:10:26 INFO - PROCESS | 22155 | _x_x_mozilla_page_load_details 16:10:26 INFO - PROCESS | 22155 | |i|pagename|runs| 16:10:26 INFO - PROCESS | 22155 | |0;dojo.html;2585.8707064646765;2599.3111825366295;2625.566781481056;2638.617400476931;2653.3234025323527;4580.770961451923;4634.281686338614;4771.117343291494;4773.498782627822;4773.832915847946;4685.3206285088645;4711.623070154388;4720.622350211984;4764.237721964478;4805.159097157992;4275.4228179195725;4292.527821939584;4346.565343465644;4357.324614684713;4386.736795792247;3929.292727309083;4372.628326592244;4393.7363758174615;4419.071994881079;4474.149911516802;4256.08494173751;4377.978110109461;4389.626881715058;4444.400005999198;4490.730556166624;4282.807273672661;4345.087531618364;4355.412019377375;4357.215701173787;4359.084592235635;4294.892627684301;4295.484541854966;4323.3947247385395;4329.588689074533;4333.371661109153;4699.600533954618;4727.834525791615;4735.5974742146955;4781.282807578857;4796.856094317176;5046.722430266371;5050.671706339113;5053.065182941167;5054.671446356012;5094.821681241138;4880.707157570557;4926.876828079291;4934.703917764909;5067.34124563808;5101.15830887903;4602.953970460319;4654.720716757005;4658.277966915133;4659.534046595381;4666.043461090469;5075.720835354017;5084.567811736044;5087.491250874883;5089.109405853961;5094.2358646203365;4933.555979961749;4998.325226094431;5001.149804533238;5027.245913113063;5066.746662666852;5094.541491265803;5098.643094983316;5099.643024988215;5100.1074811907765;5156.407013193456;5054.4187418447345;5056.544910958031;5061.493850614909;5063;5104.770285337168;4888.071266459361;4939.061578300111;4940.258961155855;5002.874928126753;5014.824481143215;4365.148795984816;4379.430674012358;4382.496012958551;4383.3424986251675;4385.429894113809;3850.306944749916;3855.7300988931065;3864.942025869614;3865.8840234793;3869.4582758413844;4376.431063961664;4385.451818522684;4387.034852332482;4388.144311859221;4390.297552391666;5042.899142017139;5080.415752188472;5089.109405853961;5123.154679477844;5195.272661827347;4392.099619577979;4433.490148632948;4437.312216606431;4445.822167113344;4447.310666846644;4618.838340658061;4624.630029597624;4625.560571745679;4628.467726211461;4683.180443422388;4582.175208462509;4778.331033655291;4798.49615790351;4799.640026997919;4833.734144622009;4937.061958227925;5008.474110218374;5024.799008039638;5071.898562028812;5072.061668591323;4753.809847606195;4755.738434386142;4757.666963312673;4801.855944321676;4813.927791083067;5000.224965130411;5004.874878128076;5005.924911126409;5010.073136469765;5051.545360917535;4905.705657660552;4945.1346014448045;4962.379702537183;5027.74861256943;5069.340985671839;4918;4955.281484184845;4956.132676781621;5010.799568017239;5018.347614810052;4906.386701662293;4929.334539837219;4935.235038569028;4941.357623508921;5000.12497812874;4745.715257084586;4796.904061918812;4875.317455556154;4903.362562866947;4985.551300382983;4957.479464656303;4958.305837182726;4987.177115776001;5010.799568017239;5065.3161823153405;4904.5340692634145;4907.067657145131;4907.435644900739;4927.211646136601;4962.478939711278 16:10:26 INFO - PROCESS | 22155 | |1;ext.html;564.0157924421882;564.7119968815904;568.0598609301608;576.8817392434552;577.7862190989334;27065.458690826195;37504.24991500172;38351.42472862909;38472.422913656315;41527.58472415275;38201.426978595344;38487.422688659695;38515.80742096293;38583.80708096456;38639.42040869389;7555.84888302235;7706.6146692665425;7718.768436946901;7734.497257678233;7739.922600773976;7117.110361204849;7321.670524826369;9303.069693030677;9544.475053872035;9545.188658963962;9610.183134433546;9692.418454892693;9696.709098727015;9702.126808587225;9708.514574271294;9371.109744574254;9423.10480504351;9426.717198483988;9436.764080897963;9440.527973601293;9747.658831940847;9809.950950245204;9815.950920245425;9825;9831.213502919822;36514.81742591297;36649.63350366516;36736.63263367386;36861;36949.63050369516;2967.1543610071026;3029.6364436267568;3107.322046095106;3193.8403079845916;3314.8176850273226;27817.304567385774;28407.715922840714;28528;29006.564901526493;29077.854610727023;3391.8304084795664;3440.7419443541585;3470.8785192518394;3534.540509733744;3543.4330507118993;232688;232770.9999999983;233075;233185;233978;30530;31552.526712099338;31597.526037109463;32760.344793104483;48148.75925620349;32173.356532869213;32291.677083228868;32316.35367292641;32347;32348.206876556185;11541.07671386287;11586.420678966018;11597.18819682631;11604.477798499087;11606.70983225426;9073.410228335137;9325.114114159143;10300.22748293881;10386.376817390981;10411.219158563137;7346.96326518364;7632.313091821763;7635.389168866477;7676.385889128856;7756.534607923542;3042.239440139965;3054.4196602645425;3068.3709839482854;3084.7532197424152;3107.5494053362586;810.440795850861;863.572531596851;941.1153515695224;968.7481254873643;1009.5608410341525;26495.282783407147;26525.734742652712;26660;26891.193264201713;27098.322541936213;915.9221466175317;916.3173435790379;953.7281874665687;978.7846673731767;994.6568433890296;13873.930630346784;14374.425022999172;14597.78103328451;14657.853421465863;14727.558173254605;363363.480469355;364319;366183.39615849766;366241;367837;46647.30029049567;46963.999999999316;46977.76511117422;47033;47102;1045.3884477580548;1083.9620613278498;1140.8402823604868;1172.6188988578747;1188.2276520261898;25747.227583172535;27762.72237277682;27930.720692792813;28124.32861846582;28458.28854278577;39140.6085939137;39916;39962.60037399589;39992.2001559973;40029.599704003755;273395;274437;274755;275462;275927;24062.27813165608;24202.394940126636;24469.143579974614;24756.25731228066;25494.107706230192;39197.216055679295;39221.62724304636;39371.803140985256;39507.60492395039;40194.799026004686;33219;33825.15437114092;34094;34170.48744268788;34213.82893085518;33666.663333366356;34220.48669270013;34291;34975.300493990486;35562.28875422425;32819.17952051218;33374.33251334911;33532;33706.49440258349;33877.66122338745;27761.86119069392;29861.402771944006;31425.21436964094;31492.685073148976;31897.521537177425;23897.163599273943;23925.16261930824;24298.271051867767;24685.62971555464;24911.750882490942 16:10:26 INFO - PROCESS | 22155 | |2;jquery.html;320.66330353129206;336.19313647246605;337.9341028499442;341.7249114462857;363.81809095452275;12100.757984840298;13183.274919879415;15398.846011539881;16317.755233671474;17522.12389380532;15832.920835395837;16078.356865725385;16376.672466550663;17166;17480.47558573245;4249.936250956238;4767.11808315461;4814.371139407738;4985.227289770091;4985.800567977277;4931.200111959127;4959.380077490314;4973.428055773578;5036.521530454601;5043.646944713872;4753.239481682931;4945.505449455044;4951.727654978975;4954.925676114861;4959.280904268879;4866;4955.975220123876;4957.5042495750495;4959.925601115986;4961.479044700309;4382.758948257876;4388.780560971939;4407.493138289074;4408.933865992013;4411.558844115595;18299.359522416784;19094.14076366567;19165.61668766617;20014.89992550028;20041;1871.9344822931132;1876.6152938647544;1903.7334773131772;1963.2147141143657;2385.807096451774;8732.122593642398;9463.574139163755;9695.806083878353;12168.391580421032;12886.484540618365;1770.0795586295183;1777;1783.2510345654855;1793.4529968359645;1815.972760408595;65485.67257163731;66204.39342885443;69701;69869.30130698679;70747.29252707459;9815.411075335503;9987.350822196535;10028.949855250823;10036.24728145392;10298.691039268833;13855.307234638227;13870.722585548232;13876.653083672787;13879.722405552035;13884.514042008683;6846.178458585002;6935.653217339112;6955.1653801544135;7093.184283807325;7175.425965922714;6483.481321494269;6554.541182117301;6686.13080299558;6705.899411508832;6745.156855393076;4237.410970885918;4311.396404503372;4355.7822108894425;4419.558044195619;4482.260427029503;1654.619437529375;1720.1915099903026;1817.972730409045;1889.8488120950292;1891.8108189181246;803.7227156630953;822.7655118291258;889.4485419040108;899.869518919753;911.8221946720325;15835.524934251991;16655.7521283351;16930.492085237463;17328.39350622722;17512.91243543774;832.8500869843486;860.4665107633182;860.4966094834467;862.1809281182901;872.8472517309445;9157.679481218125;9294.90705092954;9500.714978550655;9569.61721531131;9601.423914565148;374929;376990;378894.89280111884;379976;380508;45030;50765;68899.96650050253;76935;78727.60636196782;861.237804542984;887.5429153985702;892.7277180460022;898.3352319283814;899.4513346858411;14162.645933851736;14667.413303467742;15024.474143404928;15308.540743777705;15697.686046278783;35438;35726.642733572335;36297.637023629424;36598.8170059148;37263;51412;51430;51486;52154.47845521648;52747;7409.555426674417;7589.506682065648;7677.385809135368;7803.92196078032;7854.803629909069;11663.825042624538;11823.645290641294;11824.349660768741;11901.702457438634;11907.76184476323;9531.809363812823;9838.557264922953;10317;10436.791264174826;10628.84056739165;9992.900070999487;10481.109105725795;10485.737856553647;10501.789964200825;10820.89179108199;10311.484425778832;10392.896071039193;10548.789024219626;10852.945735271589;11051.281666691639;7758.650860711168;7869.134395216407;7969.1632378601735;8072.394570407126;8160.673573057249;9447.433154010781;9542.42745435276;9829.213662906806;9912.454814985245;10027.29808913369 16:10:26 INFO - PROCESS | 22155 | |3;mootools.html;1212.8605210400806;1334.8731870472309;1372.6362513933807;1411.1533080151903;1667.8332166783316;6158.445739883409;6911.9654401727985;6950.165980082397;7054.85890282194;7256.201817800038;7139.464540159496;7194.0647715797;7204.855902881953;7209.855802883939;7216.747413840517;2070.347840430263;2098.5593025464673;2099.5381016176416;2100.6218880601486;2104.326615483046;2032.4613977295955;2062.4019034479984;2063.5563353878915;2071.7410323709537;2083.6874468829647;2054.969175462362;2065.1326442893946;2066.0599427260636;2066.6486697261425;2067.65883629201;2055.0546748495562;2058.197303051811;2066.2974588639936;2067.059487932987;2070.4202823209525;2000.6795514960056;2008.106392655269;2041.622299874528;2046.3144846476448;2046.9181232750673;7153.570785752871;7192.35268825803;7196.172440169343;7241.42068634508;7284.599347035911;4445.955540444586;4569.794359253841;4577.198990176706;4579.702319349231;4583.266677331644;2728.6179934809143;2840.97724819065;2900.550414685727;2904.811187272842;2929.1651879214533;909.4679612426738;917.6696389299847;939.736873675372;945.5933948402185;947.5783276441986;9405.059494050609;9578.856317155249;9614;9614.663486777928;9622.951885240598;3788.318102741478;3803.8668646597234;3852.9036774080873;3953.189596132786;3971.920561588752;7639.236076392316;7719.807004824812;7732.4200684948855;7747.186545412763;7750.224977502317;4360.018995725936;4360.106178233455;4363.36731173978;4364.781760911942;4371.0602220522105;3532.911677208039;3642.5446819147605;3802.753549497425;4060.573639767782;4088.979555102265;2961.6890226526334;3067.6318841739135;3377.3920694275266;3443.2080621456703;3466.6360032196258;982.94102353859;988.9011098890197;990.97027089186;999.4752754803641;1000.8040391731811;634.7746549974693;692.3215249055953;731.6268702961528;732.8607564562716;756.8032311598914;4613.953860461353;4651.720896746206;4672.509386514435;4738.407699037621;4919.77860996256;390.4904100149332;393.39810090561485;398.02682441430426;398.0863917309781;403.3485920238852;3311.387393332241;3338.7996720196866;3349.531065650811;3370.241695618515;3392.7107699074195;8455.95772021136;8772.298216142693;8797.780055498664;8819.559022048872;8899.688510902088;8830.779230519289;8831.381803273838;8831.779205519784;8836.911630883738;8862;6495.1231583736535;6728.7308507659145;6736.797896063126;6767.086443330088;6806.217285012188;4921.803127874988;5063.468335824686;5076.18780995039;5125.4362020177;5234.842954711365;7888.802779930547;8065.637046332812;8086.83826323482;8151.918480815353;8384.958075209584;8139.982502187227;8198.508089514648;8282.213189746964;8290.792730181794;8294.29498492635;6206.689665516797;6361.109444677656;6363.300036996019;6365.713542890674;6366.236051673829;6730.192376914802;6782.966085169543;6791.252962174256;6791.830204244933;6798.728050878108;6078.240219972504;6306.873862522815;6381.680915954276;6413.262474815456;6437.549371544134;6050.667213303311;6212.875742485216;6306.716197771203;6323.367663233824;6490.967545162244;5699.487046165699;5764.711764411846;5768.336641286306;5768.826935191951;5783.537317014545;4176.770277634638;4223.324268117087;4311.396404503309;4360.803763830571;4432.490263619725;4132.607402296777;4297.54875738043;4314.525402205818;4345.674074444366;4373.103513779731 16:10:26 INFO - PROCESS | 22155 | |4;prototype.html;275.9641246637938;276.12193225542774;280.10227221754275;287.31204175469105;289.24074304949505;4697.342372067913;4851.151048566504;4880.78036488358;4896.387951506062;4925.9261111083315;4639.582437580617;4800.279958006292;4807.639427042968;4810.422749270093;4880.219164933611;3589.4974703541525;3763.3978563429855;3773.924521509568;3786.110264087944;3812.1422679897078;3698.4822124902535;3714.591394946567;3766.472693822867;3787.4660762391277;3794.430835374702;3759.793211373373;3763.266163098197;3767.2842159989514;3767.5478942526934;3769.359208934474;3770.1517158639363;3771.69826413889;3774.301754175486;3781.111438811877;3815.1606646537716;3226.128945184787;3326.5716027300205;3329.983350083234;3334.499825026241;3348.313595712873;4676.134915040694;4681.438227412698;4693.178693728618;4696.976515117402;4712.505186955389;4309.806058727365;4313.719608225455;4315.05068884848;4337.392765012901;4353.956460435386;4845.9030819383415;5060.38182699368;5087.542121209109;5100.974495127538;5125.743712814382;3581.3732596795717;3588.049166970755;3595.1191957970464;3596.730245231618;3599.280143971216;5303.416624171338;5347.850212204395;5354.651947623431;5368.731563421852;5381.300430943952;3475;3621.5292012038794;3633.8364773585254;3671.761335513183;3672.843054437897;3690.7785532868115;3706.4069748840056;3707.277080969185;3710.6660400563537;3713.20166164276;4255.106427650228;4259.105587826592;4269.637080848101;4274.337477690963;4288.849890253826;4754.076243110462;4895.6083513318845;5086.364204474441;5095.694258344437;5109.897802044013;1131.0273165078027;1261.829652996852;1264.5447638850007;1274.5921305182253;1276.4830243751296;784.9450538462366;798.6246464161835;803.8352137811735;813.7427674243309;815.9347252219808;3982.422548730418;4008.8396464141106;4033.954364454818;4039.1315867088715;4059.6752259819737;4582.95417045832;4595.93106103402;4628.259478483494;4646.83736069236;4670.813167473263;4026.416169655384;4039.091204478969;4039.5152581690386;4100.097978444737;4106.474518171303;2298.287530865404;2467.679201703767;2469.2468797016722;2469.715982662017;2533.278015765498;4311.719738217069;4316.309390497506;4355.956440435619;4379.868603941887;4399.758013309235;4629.583337499641;4649.256119021008;4656.185167595657;4668.996165824296;4775.403074615673;4339.522652508222;4354.496164705244;4548.818047278138;4918.458969513422;5035.144025515744;5279.577633789365;5291.497307755757;5298.178782288752;5336.493033161843;5355.25026496283;5257.579393648422;5260.237265596544;5265.76254580181;5277.709725965109;5278.9472105278455;4735.526447355374;4925.458199598113;4978.900421991612;4983.177775667119;5024.9748751257475;3617.385044542487;3641.1807343347537;3681.7790932544135;3704.5739739930254;3705.870294539678;5103.591712662904;5348.465153484621;5378.731063446734;5379.1393377059485;5386.730663466889;4890.413150421972;5036.546710796046;5079.187330027178;5086.338775959101;5176.741162941913;5058.2918391425965;5084.542391184811;5095.872603184802;5111.182210846247;5165.276861239505;4876.95123048765;5006.799728010838;5062.341895553554;5068.746562671926;5128.538431541179;5122.871928201825;5133.1273683473155;5137.460566640599;5141.562967147835;5145.588352931832;5024.472430394902;5028.245763135559;5048.318477005557;5078.847634570969;5104.489551044866 16:10:26 INFO - PROCESS | 22155 | |5;yui.html;640.1486023588627;670.832291927018;684.8014075917984;718.1812733483828;731.8682637125315;13067.673308167301;14398.136111833284;14403.063800852937;14417.92791036046;14431.061980971243;12337.198082124678;12433.875661243384;12553.811692824615;12780.55268065618;13099.410526526306;623.6164758673428;765.5751058162717;789.6722860013087;792.6235038356763;792.9920700792976;641.9133416988717;763.6754379388738;790.4585359029055;796.1600511460407;798.6964953317731;831.8752187171912;834.3825569078869;834.9874751878726;835.0730688935276;835.0855812884881;659.6306068601599;827.5986146718836;827.93790465715;828.2504333578122;828.2835347424465;497.44783290547826;570.8829689913558;588.9869424589699;591.9260092488439;596.803054991856;13391.732165356638;13502;13504;13516.932415337958;13521.323933803369;11870.643880683507;12240.95232875068;12477.188982716094;12571.685707857285;12969.157004794659;11722.531098756039;11905.464254108585;11942.880571194264;11969.281843089442;12557.686057848627;3215.5015972524297;4114.341705327133;4126.896827579335;4216.03031302799;4274.5939135782055;58184.709076454346;58299;58674.41325586732;59248.70375648137;59985.7000714998;9582.377145485521;9843.75390615226;9897.208223342115;9973.202143828476;10038.949805251073;17450.47648570545;17629.382971595933;17655;17707.46877593674;17840.732389014174;6589.374009469093;6644.933550664431;6656.068150458939;6661.3005634408655;6701.061851340816;3554.591222009502;3557.8043207623314;3603.5135256740004;3618.3306088373733;3825.9426108608395;3018.9698103019127;3132.2482604174834;3154.242981684379;3164.3671265746943;3165.113768144923;474.33592969841806;517.6919732759078;518.7872972081428;524.1299442924803;528.8624957510998;591.1753104419311;597.1937883856758;613.2058983616139;615.9784407545715;620.9751609935552;8025.197480252044;8261.752147435587;8303.8339233215;8388.496690198486;8574.894298878435;569.4931510955253;584.6112335297065;604.2835667614313;607.3289015637745;607.5746977116037;3673.632636736305;3707.7404581679025;3724.7392682511963;3733.4213196954515;3905;97067.51466242624;97173.51413242889;97220;101391.49304253432;101845.49077254566;83532;85055;87628.5618571903;88039.55980220185;88556.47269981995;76328;76891;76966.6151669238;78190.6090469544;78717;8008.677483529944;8109.675612975415;8135.79660508492;8241;8374.162583741578;40375.59624403718;40765.592344076176;41489.792551037055;41811.7909410451;42047.36928946007;60048.39951600428;60553.39446605478;60794;62448.375516244254;63570.68214658897;11120.277181983145;11175;11238.887611124112;11318.32090074598;11557.13321500874;12106.394680265776;12118.757624847278;12937.611871643865;13126.212427254395;13220.206787592775;11505.250411894556;11745.530178793095;12212.69468263265;12253.387330633612;12623.179493332904;10633.680989570325;11508.251963622337;12040.638780836589;12100.273983561014;12209.511619535475;11278.887211127783;11533.192676512563;11626.302421854716;11828.349440780496;12002.699932501757;9197.218236449977;9497.382670126419;9502.85745713801;9549.418967887043;10336.431496267778;9586.472743998867;9848.901510984799;9999.400035997864;10032.799344012932;10105.44420056904 16:10:26 INFO - PROCESS | 22155 | __end_tp_report 16:10:26 INFO - PROCESS | 22155 | __start_cc_report 16:10:26 INFO - PROCESS | 22155 | _x_x_mozilla_cycle_collect,1627 16:10:26 INFO - PROCESS | 22155 | __end_cc_report 16:10:26 INFO - PROCESS | 22155 | __startTimestamp1476486626186__endTimestamp 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | ------- Summary: start ------- 16:10:26 INFO - PROCESS | 22155 | Number of tests: 6 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#0] dojo.html Cycles:165 Average:4681.01 Median:4799.64 stddev:482.31 (10.0%) stddev-sans-first:454.93 16:10:26 INFO - PROCESS | 22155 | Values: 2585.9 2599.3 2625.6 2638.6 2653.3 4580.8 4634.3 4771.1 4773.5 4773.8 4685.3 4711.6 4720.6 4764.2 4805.2 4275.4 4292.5 4346.6 4357.3 4386.7 3929.3 4372.6 4393.7 4419.1 4474.1 4256.1 4378.0 4389.6 4444.4 4490.7 4282.8 4345.1 4355.4 4357.2 4359.1 4294.9 4295.5 4323.4 4329.6 4333.4 4699.6 4727.8 4735.6 4781.3 4796.9 5046.7 5050.7 5053.1 5054.7 5094.8 4880.7 4926.9 4934.7 5067.3 5101.2 4603.0 4654.7 4658.3 4659.5 4666.0 5075.7 5084.6 5087.5 5089.1 5094.2 4933.6 4998.3 5001.1 5027.2 5066.7 5094.5 5098.6 5099.6 5100.1 5156.4 5054.4 5056.5 5061.5 5063.0 5104.8 4888.1 4939.1 4940.3 5002.9 5014.8 4365.1 4379.4 4382.5 4383.3 4385.4 3850.3 3855.7 3864.9 3865.9 3869.5 4376.4 4385.5 4387.0 4388.1 4390.3 5042.9 5080.4 5089.1 5123.2 5195.3 4392.1 4433.5 4437.3 4445.8 4447.3 4618.8 4624.6 4625.6 4628.5 4683.2 4582.2 4778.3 4798.5 4799.6 4833.7 4937.1 5008.5 5024.8 5071.9 5072.1 4753.8 4755.7 4757.7 4801.9 4813.9 5000.2 5004.9 5005.9 5010.1 5051.5 4905.7 4945.1 4962.4 5027.7 5069.3 4918.0 4955.3 4956.1 5010.8 5018.3 4906.4 4929.3 4935.2 4941.4 5000.1 4745.7 4796.9 4875.3 4903.4 4985.6 4957.5 4958.3 4987.2 5010.8 5065.3 4904.5 4907.1 4907.4 4927.2 4962.5 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#1] ext.html Cycles:180 Average:42916.36 Median:34217.16 stddev:78017.08 (228.0%) stddev-sans-first:78171.13 16:10:26 INFO - PROCESS | 22155 | Values: 564.0 564.7 568.1 576.9 577.8 27065.5 37504.2 38351.4 38472.4 41527.6 38201.4 38487.4 38515.8 38583.8 38639.4 7555.8 7706.6 7718.8 7734.5 7739.9 7117.1 7321.7 9303.1 9544.5 9545.2 9610.2 9692.4 9696.7 9702.1 9708.5 9371.1 9423.1 9426.7 9436.8 9440.5 9747.7 9810.0 9816.0 9825.0 9831.2 36514.8 36649.6 36736.6 36861.0 36949.6 2967.2 3029.6 3107.3 3193.8 3314.8 27817.3 28407.7 28528.0 29006.6 29077.9 3391.8 3440.7 3470.9 3534.5 3543.4 232688.0 232771.0 233075.0 233185.0 233978.0 30530.0 31552.5 31597.5 32760.3 48148.8 32173.4 32291.7 32316.4 32347.0 32348.2 11541.1 11586.4 11597.2 11604.5 11606.7 9073.4 9325.1 10300.2 10386.4 10411.2 7347.0 7632.3 7635.4 7676.4 7756.5 3042.2 3054.4 3068.4 3084.8 3107.5 810.4 863.6 941.1 968.7 1009.6 26495.3 26525.7 26660.0 26891.2 27098.3 915.9 916.3 953.7 978.8 994.7 13873.9 14374.4 14597.8 14657.9 14727.6 363363.5 364319.0 366183.4 366241.0 367837.0 46647.3 46964.0 46977.8 47033.0 47102.0 1045.4 1084.0 1140.8 1172.6 1188.2 25747.2 27762.7 27930.7 28124.3 28458.3 39140.6 39916.0 39962.6 39992.2 40029.6 273395.0 274437.0 274755.0 275462.0 275927.0 24062.3 24202.4 24469.1 24756.3 25494.1 39197.2 39221.6 39371.8 39507.6 40194.8 33219.0 33825.2 34094.0 34170.5 34213.8 33666.7 34220.5 34291.0 34975.3 35562.3 32819.2 33374.3 33532.0 33706.5 33877.7 27761.9 29861.4 31425.2 31492.7 31897.5 23897.2 23925.2 24298.3 24685.6 24911.8 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#2] jquery.html Cycles:180 Average:23455.14 Median:4410.25 stddev:62325.69 (1413.2%) stddev-sans-first:62476.33 16:10:26 INFO - PROCESS | 22155 | Values: 320.7 336.2 337.9 341.7 363.8 12100.8 13183.3 15398.8 16317.8 17522.1 15832.9 16078.4 16376.7 17166.0 17480.5 4249.9 4767.1 4814.4 4985.2 4985.8 4931.2 4959.4 4973.4 5036.5 5043.6 4753.2 4945.5 4951.7 4954.9 4959.3 4866.0 4956.0 4957.5 4959.9 4961.5 4382.8 4388.8 4407.5 4408.9 4411.6 18299.4 19094.1 19165.6 20014.9 20041.0 1871.9 1876.6 1903.7 1963.2 2385.8 8732.1 9463.6 9695.8 12168.4 12886.5 1770.1 1777.0 1783.3 1793.5 1816.0 65485.7 66204.4 69701.0 69869.3 70747.3 9815.4 9987.4 10028.9 10036.2 10298.7 13855.3 13870.7 13876.7 13879.7 13884.5 6846.2 6935.7 6955.2 7093.2 7175.4 6483.5 6554.5 6686.1 6705.9 6745.2 4237.4 4311.4 4355.8 4419.6 4482.3 1654.6 1720.2 1818.0 1889.8 1891.8 803.7 822.8 889.4 899.9 911.8 15835.5 16655.8 16930.5 17328.4 17512.9 832.9 860.5 860.5 862.2 872.8 9157.7 9294.9 9500.7 9569.6 9601.4 374929.0 376990.0 378894.9 379976.0 380508.0 45030.0 50765.0 68900.0 76935.0 78727.6 861.2 887.5 892.7 898.3 899.5 14162.6 14667.4 15024.5 15308.5 15697.7 35438.0 35726.6 36297.6 36598.8 37263.0 51412.0 51430.0 51486.0 52154.5 52747.0 7409.6 7589.5 7677.4 7803.9 7854.8 11663.8 11823.6 11824.3 11901.7 11907.8 9531.8 9838.6 10317.0 10436.8 10628.8 9992.9 10481.1 10485.7 10501.8 10820.9 10311.5 10392.9 10548.8 10852.9 11051.3 7758.7 7869.1 7969.2 8072.4 8160.7 9447.4 9542.4 9829.2 9912.5 10027.3 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#3] mootools.html Cycles:180 Average:4719.75 Median:5467.17 stddev:2604.20 (47.6%) stddev-sans-first:2598.17 16:10:26 INFO - PROCESS | 22155 | Values: 1212.9 1334.9 1372.6 1411.2 1667.8 6158.4 6912.0 6950.2 7054.9 7256.2 7139.5 7194.1 7204.9 7209.9 7216.7 2070.3 2098.6 2099.5 2100.6 2104.3 2032.5 2062.4 2063.6 2071.7 2083.7 2055.0 2065.1 2066.1 2066.6 2067.7 2055.1 2058.2 2066.3 2067.1 2070.4 2000.7 2008.1 2041.6 2046.3 2046.9 7153.6 7192.4 7196.2 7241.4 7284.6 4446.0 4569.8 4577.2 4579.7 4583.3 2728.6 2841.0 2900.6 2904.8 2929.2 909.5 917.7 939.7 945.6 947.6 9405.1 9578.9 9614.0 9614.7 9623.0 3788.3 3803.9 3852.9 3953.2 3971.9 7639.2 7719.8 7732.4 7747.2 7750.2 4360.0 4360.1 4363.4 4364.8 4371.1 3532.9 3642.5 3802.8 4060.6 4089.0 2961.7 3067.6 3377.4 3443.2 3466.6 982.9 988.9 991.0 999.5 1000.8 634.8 692.3 731.6 732.9 756.8 4614.0 4651.7 4672.5 4738.4 4919.8 390.5 393.4 398.0 398.1 403.3 3311.4 3338.8 3349.5 3370.2 3392.7 8456.0 8772.3 8797.8 8819.6 8899.7 8830.8 8831.4 8831.8 8836.9 8862.0 6495.1 6728.7 6736.8 6767.1 6806.2 4921.8 5063.5 5076.2 5125.4 5234.8 7888.8 8065.6 8086.8 8151.9 8385.0 8140.0 8198.5 8282.2 8290.8 8294.3 6206.7 6361.1 6363.3 6365.7 6366.2 6730.2 6783.0 6791.3 6791.8 6798.7 6078.2 6306.9 6381.7 6413.3 6437.5 6050.7 6212.9 6306.7 6323.4 6491.0 5699.5 5764.7 5768.3 5768.8 5783.5 4176.8 4223.3 4311.4 4360.8 4432.5 4132.6 4297.5 4314.5 4345.7 4373.1 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#4] prototype.html Cycles:180 Average:4128.12 Median:4628.92 stddev:1226.90 (26.5%) stddev-sans-first:1195.79 16:10:26 INFO - PROCESS | 22155 | Values: 276.0 276.1 280.1 287.3 289.2 4697.3 4851.2 4880.8 4896.4 4925.9 4639.6 4800.3 4807.6 4810.4 4880.2 3589.5 3763.4 3773.9 3786.1 3812.1 3698.5 3714.6 3766.5 3787.5 3794.4 3759.8 3763.3 3767.3 3767.5 3769.4 3770.2 3771.7 3774.3 3781.1 3815.2 3226.1 3326.6 3330.0 3334.5 3348.3 4676.1 4681.4 4693.2 4697.0 4712.5 4309.8 4313.7 4315.1 4337.4 4354.0 4845.9 5060.4 5087.5 5101.0 5125.7 3581.4 3588.0 3595.1 3596.7 3599.3 5303.4 5347.9 5354.7 5368.7 5381.3 3475.0 3621.5 3633.8 3671.8 3672.8 3690.8 3706.4 3707.3 3710.7 3713.2 4255.1 4259.1 4269.6 4274.3 4288.8 4754.1 4895.6 5086.4 5095.7 5109.9 1131.0 1261.8 1264.5 1274.6 1276.5 784.9 798.6 803.8 813.7 815.9 3982.4 4008.8 4034.0 4039.1 4059.7 4583.0 4595.9 4628.3 4646.8 4670.8 4026.4 4039.1 4039.5 4100.1 4106.5 2298.3 2467.7 2469.2 2469.7 2533.3 4311.7 4316.3 4356.0 4379.9 4399.8 4629.6 4649.3 4656.2 4669.0 4775.4 4339.5 4354.5 4548.8 4918.5 5035.1 5279.6 5291.5 5298.2 5336.5 5355.3 5257.6 5260.2 5265.8 5277.7 5278.9 4735.5 4925.5 4978.9 4983.2 5025.0 3617.4 3641.2 3681.8 3704.6 3705.9 5103.6 5348.5 5378.7 5379.1 5386.7 4890.4 5036.5 5079.2 5086.3 5176.7 5058.3 5084.5 5095.9 5111.2 5165.3 4877.0 5006.8 5062.3 5068.7 5128.5 5122.9 5133.1 5137.5 5141.6 5145.6 5024.5 5028.2 5048.3 5078.8 5104.5 16:10:26 INFO - PROCESS | 22155 | 16:10:26 INFO - PROCESS | 22155 | [#5] yui.html Cycles:180 Average:17763.95 Median:526.50 stddev:25493.19 (4842.0%) stddev-sans-first:25532.28 16:10:26 INFO - PROCESS | 22155 | Values: 640.1 670.8 684.8 718.2 731.9 13067.7 14398.1 14403.1 14417.9 14431.1 12337.2 12433.9 12553.8 12780.6 13099.4 623.6 765.6 789.7 792.6 793.0 641.9 763.7 790.5 796.2 798.7 831.9 834.4 835.0 835.1 835.1 659.6 827.6 827.9 828.3 828.3 497.4 570.9 589.0 591.9 596.8 13391.7 13502.0 13504.0 13516.9 13521.3 11870.6 12241.0 12477.2 12571.7 12969.2 11722.5 11905.5 11942.9 11969.3 12557.7 3215.5 4114.3 4126.9 4216.0 4274.6 58184.7 58299.0 58674.4 59248.7 59985.7 9582.4 9843.8 9897.2 9973.2 10038.9 17450.5 17629.4 17655.0 17707.5 17840.7 6589.4 6644.9 6656.1 6661.3 6701.1 3554.6 3557.8 3603.5 3618.3 3825.9 3019.0 3132.2 3154.2 3164.4 3165.1 474.3 517.7 518.8 524.1 528.9 591.2 597.2 613.2 616.0 621.0 8025.2 8261.8 8303.8 8388.5 8574.9 569.5 584.6 604.3 607.3 607.6 3673.6 3707.7 3724.7 3733.4 3905.0 97067.5 97173.5 97220.0 101391.5 101845.5 83532.0 85055.0 87628.6 88039.6 88556.5 76328.0 76891.0 76966.6 78190.6 78717.0 8008.7 8109.7 8135.8 8241.0 8374.2 40375.6 40765.6 41489.8 41811.8 42047.4 60048.4 60553.4 60794.0 62448.4 63570.7 11120.3 11175.0 11238.9 11318.3 11557.1 12106.4 12118.8 12937.6 13126.2 13220.2 11505.3 11745.5 12212.7 12253.4 12623.2 10633.7 11508.3 12040.6 12100.3 12209.5 11278.9 11533.2 11626.3 11828.3 12002.7 9197.2 9497.4 9502.9 9549.4 10336.4 9586.5 9848.9 9999.4 10032.8 10105.4 16:10:26 INFO - PROCESS | 22155 | -------- Summary: end -------- 16:10:26 INFO - PROCESS | 22155 | 16:10:27 INFO - TEST-INFO | 22155: exit 0 16:10:27 INFO - TEST-OK | dromaeo_css | took 1122005ms 16:10:27 INFO - TEST-START | kraken 16:10:27 INFO - operating with platform_type : linux_ 16:10:27 INFO - Initialising browser for kraken test... 16:10:27 INFO - TEST-INFO | started process 22463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvXDpw/profile http://localhost:60372/getInfo.html) 16:10:31 INFO - PROCESS | 22463 | __metrics Screen width/height:1600/1200 16:10:31 INFO - PROCESS | 22463 | colorDepth:24 16:10:31 INFO - PROCESS | 22463 | Browser inner width/height: 1024/697 16:10:31 INFO - PROCESS | 22463 | __metrics 16:10:31 INFO - PROCESS | 22463 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:10:31 INFO - PROCESS | 22463 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:32 INFO - PROCESS | 22463 | console.error: PushService: 16:10:32 INFO - PROCESS | 22463 | stateChangeProcessEnqueue: Error transitioning state 16:10:32 INFO - PROCESS | 22463 | UnknownError 16:10:33 INFO - TEST-INFO | 22463: exit 0 16:10:33 INFO - Browser initialized. 16:10:33 INFO - Running cycle 1/1 for kraken test... 16:10:33 INFO - TEST-INFO | started process 22543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvXDpw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:45 INFO - PROCESS | 22543 | RSS: Main: 173527040 16:10:45 INFO - PROCESS | 22543 | 16:10:48 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60372/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:49 INFO - PROCESS | 22543 | RSS: Main: 230912000 16:10:49 INFO - PROCESS | 22543 | 16:10:52 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60372/tests/kraken/driver.html?testName=audio-dft) 16:10:52 INFO - PROCESS | 22543 | RSS: Main: 217227264 16:10:52 INFO - PROCESS | 22543 | 16:10:55 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60372/tests/kraken/driver.html?testName=audio-fft) 16:10:56 INFO - PROCESS | 22543 | RSS: Main: 300146688 16:10:56 INFO - PROCESS | 22543 | 16:10:58 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60372/tests/kraken/driver.html?testName=audio-oscillator) 16:10:59 INFO - PROCESS | 22543 | RSS: Main: 210530304 16:10:59 INFO - PROCESS | 22543 | 16:11:01 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:02 INFO - PROCESS | 22543 | RSS: Main: 213311488 16:11:02 INFO - PROCESS | 22543 | 16:11:05 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60372/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:05 INFO - PROCESS | 22543 | RSS: Main: 249470976 16:11:05 INFO - PROCESS | 22543 | 16:11:09 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60372/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:09 INFO - PROCESS | 22543 | RSS: Main: 248508416 16:11:09 INFO - PROCESS | 22543 | 16:11:12 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60372/tests/kraken/driver.html?testName=json-parse-financial) 16:11:13 INFO - PROCESS | 22543 | RSS: Main: 248172544 16:11:13 INFO - PROCESS | 22543 | 16:11:14 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:15 INFO - PROCESS | 22543 | RSS: Main: 210591744 16:11:15 INFO - PROCESS | 22543 | 16:11:17 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:18 INFO - PROCESS | 22543 | RSS: Main: 218025984 16:11:18 INFO - PROCESS | 22543 | 16:11:20 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:20 INFO - PROCESS | 22543 | RSS: Main: 227246080 16:11:20 INFO - PROCESS | 22543 | 16:11:23 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:24 INFO - PROCESS | 22543 | RSS: Main: 235261952 16:11:24 INFO - PROCESS | 22543 | 16:11:27 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:28 INFO - PROCESS | 22543 | RSS: Main: 232099840 16:11:28 INFO - PROCESS | 22543 | 16:11:29 INFO - PROCESS | 22543 | Cycle 1(1): loaded http://localhost:60372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60372/tests/kraken/driver.html?testName=ai-astar) 16:11:30 INFO - PROCESS | 22543 | RSS: Main: 282193920 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | __start_tp_report 16:11:30 INFO - PROCESS | 22543 | _x_x_mozilla_page_load 16:11:30 INFO - PROCESS | 22543 | _x_x_mozilla_page_load_details 16:11:30 INFO - PROCESS | 22543 | |i|pagename|runs| 16:11:30 INFO - PROCESS | 22543 | |0;ai-astar;107;116;115;115;115;117;115;115;116;114 16:11:30 INFO - PROCESS | 22543 | |1;audio-beat-detection;161;130;126;176;128;129;126;142;161;127 16:11:30 INFO - PROCESS | 22543 | |2;audio-dft;160;160;162;160;160;160;161;161;163;160 16:11:30 INFO - PROCESS | 22543 | |3;audio-fft;76;77;77;105;79;77;77;77;117;76 16:11:30 INFO - PROCESS | 22543 | |4;audio-oscillator;85;84;112;85;85;84;105;84;84;113 16:11:30 INFO - PROCESS | 22543 | |5;imaging-gaussian-blur;116;116;117;117;117;117;118;117;117;117 16:11:30 INFO - PROCESS | 22543 | |6;imaging-darkroom;147;147;147;148;148;148;148;147;148;147 16:11:30 INFO - PROCESS | 22543 | |7;imaging-desaturate;84;85;84;85;85;84;84;84;84;85 16:11:30 INFO - PROCESS | 22543 | |8;json-parse-financial;67;67;67;66;65;65;65;66;66;64 16:11:30 INFO - PROCESS | 22543 | |9;json-stringify-tinderbox;67;68;67;67;67;68;67;68;69;68 16:11:30 INFO - PROCESS | 22543 | |10;stanford-crypto-aes;87;83;83;83;83;82;84;83;83;83 16:11:30 INFO - PROCESS | 22543 | |11;stanford-crypto-ccm;144;142;142;143;137;137;138;138;178;139 16:11:30 INFO - PROCESS | 22543 | |12;stanford-crypto-pbkdf2;179;180;177;182;177;180;176;175;178;176 16:11:30 INFO - PROCESS | 22543 | |13;stanford-crypto-sha256-iterative;71;69;73;70;71;71;70;74;70;68 16:11:30 INFO - PROCESS | 22543 | __end_tp_report 16:11:30 INFO - PROCESS | 22543 | __start_cc_report 16:11:30 INFO - PROCESS | 22543 | _x_x_mozilla_cycle_collect,1972 16:11:30 INFO - PROCESS | 22543 | __end_cc_report 16:11:30 INFO - PROCESS | 22543 | __startTimestamp1476486690149__endTimestamp 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | ------- Summary: start ------- 16:11:30 INFO - PROCESS | 22543 | Number of tests: 14 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.76 (2.4%) stddev-sans-first:0.87 16:11:30 INFO - PROCESS | 22543 | Values: 107.0 116.0 115.0 115.0 115.0 117.0 115.0 115.0 116.0 114.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:136.00 stddev:18.57 (13.7%) stddev-sans-first:18.17 16:11:30 INFO - PROCESS | 22543 | Values: 161.0 130.0 126.0 176.0 128.0 129.0 126.0 142.0 161.0 127.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 16:11:30 INFO - PROCESS | 22543 | Values: 160.0 160.0 162.0 160.0 160.0 160.0 161.0 161.0 163.0 160.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.00 stddev:14.63 (19.0%) stddev-sans-first:15.25 16:11:30 INFO - PROCESS | 22543 | Values: 76.0 77.0 77.0 105.0 79.0 77.0 77.0 77.0 117.0 76.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:84.00 stddev:12.53 (14.9%) stddev-sans-first:13.02 16:11:30 INFO - PROCESS | 22543 | Values: 85.0 84.0 112.0 85.0 85.0 84.0 105.0 84.0 84.0 113.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 16:11:30 INFO - PROCESS | 22543 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:11:30 INFO - PROCESS | 22543 | Values: 147.0 147.0 147.0 148.0 148.0 148.0 148.0 147.0 148.0 147.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 16:11:30 INFO - PROCESS | 22543 | Values: 84.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 85.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 16:11:30 INFO - PROCESS | 22543 | Values: 67.0 67.0 67.0 66.0 65.0 65.0 65.0 66.0 66.0 64.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 16:11:30 INFO - PROCESS | 22543 | Values: 67.0 68.0 67.0 67.0 67.0 68.0 67.0 68.0 69.0 68.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.35 (1.6%) stddev-sans-first:0.50 16:11:30 INFO - PROCESS | 22543 | Values: 87.0 83.0 83.0 83.0 83.0 82.0 84.0 83.0 83.0 83.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:142.00 stddev:12.29 (8.7%) stddev-sans-first:13.04 16:11:30 INFO - PROCESS | 22543 | Values: 144.0 142.0 142.0 143.0 137.0 137.0 138.0 138.0 178.0 139.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:178.50 stddev:2.21 (1.2%) stddev-sans-first:2.32 16:11:30 INFO - PROCESS | 22543 | Values: 179.0 180.0 177.0 182.0 177.0 180.0 176.0 175.0 178.0 176.0 16:11:30 INFO - PROCESS | 22543 | 16:11:30 INFO - PROCESS | 22543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.77 (2.5%) stddev-sans-first:1.87 16:11:30 INFO - PROCESS | 22543 | Values: 71.0 69.0 73.0 70.0 71.0 71.0 70.0 74.0 70.0 68.0 16:11:30 INFO - PROCESS | 22543 | -------- Summary: end -------- 16:11:30 INFO - PROCESS | 22543 | 16:11:31 INFO - TEST-INFO | 22543: exit 0 16:11:31 INFO - TEST-OK | kraken | took 64354ms 16:11:31 INFO - SUITE-END | took 1186s 16:11:31 INFO - Completed test suite (00:19:46) 16:11:31 INFO - javascript benchmark 16:11:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2585.8707064646765, 2599.3111825366295, 2625.566781481056, 2638.617400476931, 2653.3234025323527, 4580.770961451923, 4634.281686338614, 4771.117343291494, 4773.498782627822, 4773.832915847946, 4685.3206285088645, 4711.623070154388, 4720.622350211984, 4764.237721964478, 4805.159097157992, 4275.4228179195725, 4292.527821939584, 4346.565343465644, 4357.324614684713, 4386.736795792247, 3929.292727309083, 4372.628326592244, 4393.7363758174615, 4419.071994881079, 4474.149911516802, 4256.08494173751, 4377.978110109461, 4389.626881715058, 4444.400005999198, 4490.730556166624, 4282.807273672661, 4345.087531618364, 4355.412019377375, 4357.215701173787, 4359.084592235635, 4294.892627684301, 4295.484541854966, 4323.3947247385395, 4329.588689074533, 4333.371661109153, 4699.600533954618, 4727.834525791615, 4735.5974742146955, 4781.282807578857, 4796.856094317176, 5046.722430266371, 5050.671706339113, 5053.065182941167, 5054.671446356012, 5094.821681241138, 4880.707157570557, 4926.876828079291, 4934.703917764909, 5067.34124563808, 5101.15830887903, 4602.953970460319, 4654.720716757005, 4658.277966915133, 4659.534046595381, 4666.043461090469, 5075.720835354017, 5084.567811736044, 5087.491250874883, 5089.109405853961, 5094.2358646203365, 4933.555979961749, 4998.325226094431, 5001.149804533238, 5027.245913113063, 5066.746662666852, 5094.541491265803, 5098.643094983316, 5099.643024988215, 5100.1074811907765, 5156.407013193456, 5054.4187418447345, 5056.544910958031, 5061.493850614909, 5063.0, 5104.770285337168, 4888.071266459361, 4939.061578300111, 4940.258961155855, 5002.874928126753, 5014.824481143215, 4365.148795984816, 4379.430674012358, 4382.496012958551, 4383.3424986251675, 4385.429894113809, 3850.306944749916, 3855.7300988931065, 3864.942025869614, 3865.8840234793, 3869.4582758413844, 4376.431063961664, 4385.451818522684, 4387.034852332482, 4388.144311859221, 4390.297552391666, 5042.899142017139, 5080.415752188472, 5089.109405853961, 5123.154679477844, 5195.272661827347, 4392.099619577979, 4433.490148632948, 4437.312216606431, 4445.822167113344, 4447.310666846644, 4618.838340658061, 4624.630029597624, 4625.560571745679, 4628.467726211461, 4683.180443422388, 4582.175208462509, 4778.331033655291, 4798.49615790351, 4799.640026997919, 4833.734144622009, 4937.061958227925, 5008.474110218374, 5024.799008039638, 5071.898562028812, 5072.061668591323, 4753.809847606195, 4755.738434386142, 4757.666963312673, 4801.855944321676, 4813.927791083067, 5000.224965130411, 5004.874878128076, 5005.924911126409, 5010.073136469765, 5051.545360917535, 4905.705657660552, 4945.1346014448045, 4962.379702537183, 5027.74861256943, 5069.340985671839, 4918.0, 4955.281484184845, 4956.132676781621, 5010.799568017239, 5018.347614810052, 4906.386701662293, 4929.334539837219, 4935.235038569028, 4941.357623508921, 5000.12497812874, 4745.715257084586, 4796.904061918812, 4875.317455556154, 4903.362562866947, 4985.551300382983, 4957.479464656303, 4958.305837182726, 4987.177115776001, 5010.799568017239, 5065.3161823153405, 4904.5340692634145, 4907.067657145131, 4907.435644900739, 4927.211646136601, 4962.478939711278], "value": 4650.48835237661, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.0157924421882, 564.7119968815904, 568.0598609301608, 576.8817392434552, 577.7862190989334, 27065.458690826195, 37504.24991500172, 38351.42472862909, 38472.422913656315, 41527.58472415275, 38201.426978595344, 38487.422688659695, 38515.80742096293, 38583.80708096456, 38639.42040869389, 7555.84888302235, 7706.6146692665425, 7718.768436946901, 7734.497257678233, 7739.922600773976, 7117.110361204849, 7321.670524826369, 9303.069693030677, 9544.475053872035, 9545.188658963962, 9610.183134433546, 9692.418454892693, 9696.709098727015, 9702.126808587225, 9708.514574271294, 9371.109744574254, 9423.10480504351, 9426.717198483988, 9436.764080897963, 9440.527973601293, 9747.658831940847, 9809.950950245204, 9815.950920245425, 9825.0, 9831.213502919822, 36514.81742591297, 36649.63350366516, 36736.63263367386, 36861.0, 36949.63050369516, 2967.1543610071026, 3029.6364436267568, 3107.322046095106, 3193.8403079845916, 3314.8176850273226, 27817.304567385774, 28407.715922840714, 28528.0, 29006.564901526493, 29077.854610727023, 3391.8304084795664, 3440.7419443541585, 3470.8785192518394, 3534.540509733744, 3543.4330507118993, 232688.0, 232770.9999999983, 233075.0, 233185.0, 233978.0, 30530.0, 31552.526712099338, 31597.526037109463, 32760.344793104483, 48148.75925620349, 32173.356532869213, 32291.677083228868, 32316.35367292641, 32347.0, 32348.206876556185, 11541.07671386287, 11586.420678966018, 11597.18819682631, 11604.477798499087, 11606.70983225426, 9073.410228335137, 9325.114114159143, 10300.22748293881, 10386.376817390981, 10411.219158563137, 7346.96326518364, 7632.313091821763, 7635.389168866477, 7676.385889128856, 7756.534607923542, 3042.239440139965, 3054.4196602645425, 3068.3709839482854, 3084.7532197424152, 3107.5494053362586, 810.440795850861, 863.572531596851, 941.1153515695224, 968.7481254873643, 1009.5608410341525, 26495.282783407147, 26525.734742652712, 26660.0, 26891.193264201713, 27098.322541936213, 915.9221466175317, 916.3173435790379, 953.7281874665687, 978.7846673731767, 994.6568433890296, 13873.930630346784, 14374.425022999172, 14597.78103328451, 14657.853421465863, 14727.558173254605, 363363.480469355, 364319.0, 366183.39615849766, 366241.0, 367837.0, 46647.30029049567, 46963.999999999316, 46977.76511117422, 47033.0, 47102.0, 1045.3884477580548, 1083.9620613278498, 1140.8402823604868, 1172.6188988578747, 1188.2276520261898, 25747.227583172535, 27762.72237277682, 27930.720692792813, 28124.32861846582, 28458.28854278577, 39140.6085939137, 39916.0, 39962.60037399589, 39992.2001559973, 40029.599704003755, 273395.0, 274437.0, 274755.0, 275462.0, 275927.0, 24062.27813165608, 24202.394940126636, 24469.143579974614, 24756.25731228066, 25494.107706230192, 39197.216055679295, 39221.62724304636, 39371.803140985256, 39507.60492395039, 40194.799026004686, 33219.0, 33825.15437114092, 34094.0, 34170.48744268788, 34213.82893085518, 33666.663333366356, 34220.48669270013, 34291.0, 34975.300493990486, 35562.28875422425, 32819.17952051218, 33374.33251334911, 33532.0, 33706.49440258349, 33877.66122338745, 27761.86119069392, 29861.402771944006, 31425.21436964094, 31492.685073148976, 31897.521537177425, 23897.163599273943, 23925.16261930824, 24298.271051867767, 24685.62971555464, 24911.750882490942], "value": 15978.947016674942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.66330353129206, 336.19313647246605, 337.9341028499442, 341.7249114462857, 363.81809095452275, 12100.757984840298, 13183.274919879415, 15398.846011539881, 16317.755233671474, 17522.12389380532, 15832.920835395837, 16078.356865725385, 16376.672466550663, 17166.0, 17480.47558573245, 4249.936250956238, 4767.11808315461, 4814.371139407738, 4985.227289770091, 4985.800567977277, 4931.200111959127, 4959.380077490314, 4973.428055773578, 5036.521530454601, 5043.646944713872, 4753.239481682931, 4945.505449455044, 4951.727654978975, 4954.925676114861, 4959.280904268879, 4866.0, 4955.975220123876, 4957.5042495750495, 4959.925601115986, 4961.479044700309, 4382.758948257876, 4388.780560971939, 4407.493138289074, 4408.933865992013, 4411.558844115595, 18299.359522416784, 19094.14076366567, 19165.61668766617, 20014.89992550028, 20041.0, 1871.9344822931132, 1876.6152938647544, 1903.7334773131772, 1963.2147141143657, 2385.807096451774, 8732.122593642398, 9463.574139163755, 9695.806083878353, 12168.391580421032, 12886.484540618365, 1770.0795586295183, 1777.0, 1783.2510345654855, 1793.4529968359645, 1815.972760408595, 65485.67257163731, 66204.39342885443, 69701.0, 69869.30130698679, 70747.29252707459, 9815.411075335503, 9987.350822196535, 10028.949855250823, 10036.24728145392, 10298.691039268833, 13855.307234638227, 13870.722585548232, 13876.653083672787, 13879.722405552035, 13884.514042008683, 6846.178458585002, 6935.653217339112, 6955.1653801544135, 7093.184283807325, 7175.425965922714, 6483.481321494269, 6554.541182117301, 6686.13080299558, 6705.899411508832, 6745.156855393076, 4237.410970885918, 4311.396404503372, 4355.7822108894425, 4419.558044195619, 4482.260427029503, 1654.619437529375, 1720.1915099903026, 1817.972730409045, 1889.8488120950292, 1891.8108189181246, 803.7227156630953, 822.7655118291258, 889.4485419040108, 899.869518919753, 911.8221946720325, 15835.524934251991, 16655.7521283351, 16930.492085237463, 17328.39350622722, 17512.91243543774, 832.8500869843486, 860.4665107633182, 860.4966094834467, 862.1809281182901, 872.8472517309445, 9157.679481218125, 9294.90705092954, 9500.714978550655, 9569.61721531131, 9601.423914565148, 374929.0, 376990.0, 378894.89280111884, 379976.0, 380508.0, 45030.0, 50765.0, 68899.96650050253, 76935.0, 78727.60636196782, 861.237804542984, 887.5429153985702, 892.7277180460022, 898.3352319283814, 899.4513346858411, 14162.645933851736, 14667.413303467742, 15024.474143404928, 15308.540743777705, 15697.686046278783, 35438.0, 35726.642733572335, 36297.637023629424, 36598.8170059148, 37263.0, 51412.0, 51430.0, 51486.0, 52154.47845521648, 52747.0, 7409.555426674417, 7589.506682065648, 7677.385809135368, 7803.92196078032, 7854.803629909069, 11663.825042624538, 11823.645290641294, 11824.349660768741, 11901.702457438634, 11907.76184476323, 9531.809363812823, 9838.557264922953, 10317.0, 10436.791264174826, 10628.84056739165, 9992.900070999487, 10481.109105725795, 10485.737856553647, 10501.789964200825, 10820.89179108199, 10311.484425778832, 10392.896071039193, 10548.789024219626, 10852.945735271589, 11051.281666691639, 7758.650860711168, 7869.134395216407, 7969.1632378601735, 8072.394570407126, 8160.673573057249, 9447.433154010781, 9542.42745435276, 9829.213662906806, 9912.454814985245, 10027.29808913369], "value": 7988.873759177537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.8605210400806, 1334.8731870472309, 1372.6362513933807, 1411.1533080151903, 1667.8332166783316, 6158.445739883409, 6911.9654401727985, 6950.165980082397, 7054.85890282194, 7256.201817800038, 7139.464540159496, 7194.0647715797, 7204.855902881953, 7209.855802883939, 7216.747413840517, 2070.347840430263, 2098.5593025464673, 2099.5381016176416, 2100.6218880601486, 2104.326615483046, 2032.4613977295955, 2062.4019034479984, 2063.5563353878915, 2071.7410323709537, 2083.6874468829647, 2054.969175462362, 2065.1326442893946, 2066.0599427260636, 2066.6486697261425, 2067.65883629201, 2055.0546748495562, 2058.197303051811, 2066.2974588639936, 2067.059487932987, 2070.4202823209525, 2000.6795514960056, 2008.106392655269, 2041.622299874528, 2046.3144846476448, 2046.9181232750673, 7153.570785752871, 7192.35268825803, 7196.172440169343, 7241.42068634508, 7284.599347035911, 4445.955540444586, 4569.794359253841, 4577.198990176706, 4579.702319349231, 4583.266677331644, 2728.6179934809143, 2840.97724819065, 2900.550414685727, 2904.811187272842, 2929.1651879214533, 909.4679612426738, 917.6696389299847, 939.736873675372, 945.5933948402185, 947.5783276441986, 9405.059494050609, 9578.856317155249, 9614.0, 9614.663486777928, 9622.951885240598, 3788.318102741478, 3803.8668646597234, 3852.9036774080873, 3953.189596132786, 3971.920561588752, 7639.236076392316, 7719.807004824812, 7732.4200684948855, 7747.186545412763, 7750.224977502317, 4360.018995725936, 4360.106178233455, 4363.36731173978, 4364.781760911942, 4371.0602220522105, 3532.911677208039, 3642.5446819147605, 3802.753549497425, 4060.573639767782, 4088.979555102265, 2961.6890226526334, 3067.6318841739135, 3377.3920694275266, 3443.2080621456703, 3466.6360032196258, 982.94102353859, 988.9011098890197, 990.97027089186, 999.4752754803641, 1000.8040391731811, 634.7746549974693, 692.3215249055953, 731.6268702961528, 732.8607564562716, 756.8032311598914, 4613.953860461353, 4651.720896746206, 4672.509386514435, 4738.407699037621, 4919.77860996256, 390.4904100149332, 393.39810090561485, 398.02682441430426, 398.0863917309781, 403.3485920238852, 3311.387393332241, 3338.7996720196866, 3349.531065650811, 3370.241695618515, 3392.7107699074195, 8455.95772021136, 8772.298216142693, 8797.780055498664, 8819.559022048872, 8899.688510902088, 8830.779230519289, 8831.381803273838, 8831.779205519784, 8836.911630883738, 8862.0, 6495.1231583736535, 6728.7308507659145, 6736.797896063126, 6767.086443330088, 6806.217285012188, 4921.803127874988, 5063.468335824686, 5076.18780995039, 5125.4362020177, 5234.842954711365, 7888.802779930547, 8065.637046332812, 8086.83826323482, 8151.918480815353, 8384.958075209584, 8139.982502187227, 8198.508089514648, 8282.213189746964, 8290.792730181794, 8294.29498492635, 6206.689665516797, 6361.109444677656, 6363.300036996019, 6365.713542890674, 6366.236051673829, 6730.192376914802, 6782.966085169543, 6791.252962174256, 6791.830204244933, 6798.728050878108, 6078.240219972504, 6306.873862522815, 6381.680915954276, 6413.262474815456, 6437.549371544134, 6050.667213303311, 6212.875742485216, 6306.716197771203, 6323.367663233824, 6490.967545162244, 5699.487046165699, 5764.711764411846, 5768.336641286306, 5768.826935191951, 5783.537317014545, 4176.770277634638, 4223.324268117087, 4311.396404503309, 4360.803763830571, 4432.490263619725, 4132.607402296777, 4297.54875738043, 4314.525402205818, 4345.674074444366, 4373.103513779731], "value": 3758.0070607519233, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.9641246637938, 276.12193225542774, 280.10227221754275, 287.31204175469105, 289.24074304949505, 4697.342372067913, 4851.151048566504, 4880.78036488358, 4896.387951506062, 4925.9261111083315, 4639.582437580617, 4800.279958006292, 4807.639427042968, 4810.422749270093, 4880.219164933611, 3589.4974703541525, 3763.3978563429855, 3773.924521509568, 3786.110264087944, 3812.1422679897078, 3698.4822124902535, 3714.591394946567, 3766.472693822867, 3787.4660762391277, 3794.430835374702, 3759.793211373373, 3763.266163098197, 3767.2842159989514, 3767.5478942526934, 3769.359208934474, 3770.1517158639363, 3771.69826413889, 3774.301754175486, 3781.111438811877, 3815.1606646537716, 3226.128945184787, 3326.5716027300205, 3329.983350083234, 3334.499825026241, 3348.313595712873, 4676.134915040694, 4681.438227412698, 4693.178693728618, 4696.976515117402, 4712.505186955389, 4309.806058727365, 4313.719608225455, 4315.05068884848, 4337.392765012901, 4353.956460435386, 4845.9030819383415, 5060.38182699368, 5087.542121209109, 5100.974495127538, 5125.743712814382, 3581.3732596795717, 3588.049166970755, 3595.1191957970464, 3596.730245231618, 3599.280143971216, 5303.416624171338, 5347.850212204395, 5354.651947623431, 5368.731563421852, 5381.300430943952, 3475.0, 3621.5292012038794, 3633.8364773585254, 3671.761335513183, 3672.843054437897, 3690.7785532868115, 3706.4069748840056, 3707.277080969185, 3710.6660400563537, 3713.20166164276, 4255.106427650228, 4259.105587826592, 4269.637080848101, 4274.337477690963, 4288.849890253826, 4754.076243110462, 4895.6083513318845, 5086.364204474441, 5095.694258344437, 5109.897802044013, 1131.0273165078027, 1261.829652996852, 1264.5447638850007, 1274.5921305182253, 1276.4830243751296, 784.9450538462366, 798.6246464161835, 803.8352137811735, 813.7427674243309, 815.9347252219808, 3982.422548730418, 4008.8396464141106, 4033.954364454818, 4039.1315867088715, 4059.6752259819737, 4582.95417045832, 4595.93106103402, 4628.259478483494, 4646.83736069236, 4670.813167473263, 4026.416169655384, 4039.091204478969, 4039.5152581690386, 4100.097978444737, 4106.474518171303, 2298.287530865404, 2467.679201703767, 2469.2468797016722, 2469.715982662017, 2533.278015765498, 4311.719738217069, 4316.309390497506, 4355.956440435619, 4379.868603941887, 4399.758013309235, 4629.583337499641, 4649.256119021008, 4656.185167595657, 4668.996165824296, 4775.403074615673, 4339.522652508222, 4354.496164705244, 4548.818047278138, 4918.458969513422, 5035.144025515744, 5279.577633789365, 5291.497307755757, 5298.178782288752, 5336.493033161843, 5355.25026496283, 5257.579393648422, 5260.237265596544, 5265.76254580181, 5277.709725965109, 5278.9472105278455, 4735.526447355374, 4925.458199598113, 4978.900421991612, 4983.177775667119, 5024.9748751257475, 3617.385044542487, 3641.1807343347537, 3681.7790932544135, 3704.5739739930254, 3705.870294539678, 5103.591712662904, 5348.465153484621, 5378.731063446734, 5379.1393377059485, 5386.730663466889, 4890.413150421972, 5036.546710796046, 5079.187330027178, 5086.338775959101, 5176.741162941913, 5058.2918391425965, 5084.542391184811, 5095.872603184802, 5111.182210846247, 5165.276861239505, 4876.95123048765, 5006.799728010838, 5062.341895553554, 5068.746562671926, 5128.538431541179, 5122.871928201825, 5133.1273683473155, 5137.460566640599, 5141.562967147835, 5145.588352931832, 5024.472430394902, 5028.245763135559, 5048.318477005557, 5078.847634570969, 5104.489551044866], "value": 3731.3883484766543, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.1486023588627, 670.832291927018, 684.8014075917984, 718.1812733483828, 731.8682637125315, 13067.673308167301, 14398.136111833284, 14403.063800852937, 14417.92791036046, 14431.061980971243, 12337.198082124678, 12433.875661243384, 12553.811692824615, 12780.55268065618, 13099.410526526306, 623.6164758673428, 765.5751058162717, 789.6722860013087, 792.6235038356763, 792.9920700792976, 641.9133416988717, 763.6754379388738, 790.4585359029055, 796.1600511460407, 798.6964953317731, 831.8752187171912, 834.3825569078869, 834.9874751878726, 835.0730688935276, 835.0855812884881, 659.6306068601599, 827.5986146718836, 827.93790465715, 828.2504333578122, 828.2835347424465, 497.44783290547826, 570.8829689913558, 588.9869424589699, 591.9260092488439, 596.803054991856, 13391.732165356638, 13502.0, 13504.0, 13516.932415337958, 13521.323933803369, 11870.643880683507, 12240.95232875068, 12477.188982716094, 12571.685707857285, 12969.157004794659, 11722.531098756039, 11905.464254108585, 11942.880571194264, 11969.281843089442, 12557.686057848627, 3215.5015972524297, 4114.341705327133, 4126.896827579335, 4216.03031302799, 4274.5939135782055, 58184.709076454346, 58299.0, 58674.41325586732, 59248.70375648137, 59985.7000714998, 9582.377145485521, 9843.75390615226, 9897.208223342115, 9973.202143828476, 10038.949805251073, 17450.47648570545, 17629.382971595933, 17655.0, 17707.46877593674, 17840.732389014174, 6589.374009469093, 6644.933550664431, 6656.068150458939, 6661.3005634408655, 6701.061851340816, 3554.591222009502, 3557.8043207623314, 3603.5135256740004, 3618.3306088373733, 3825.9426108608395, 3018.9698103019127, 3132.2482604174834, 3154.242981684379, 3164.3671265746943, 3165.113768144923, 474.33592969841806, 517.6919732759078, 518.7872972081428, 524.1299442924803, 528.8624957510998, 591.1753104419311, 597.1937883856758, 613.2058983616139, 615.9784407545715, 620.9751609935552, 8025.197480252044, 8261.752147435587, 8303.8339233215, 8388.496690198486, 8574.894298878435, 569.4931510955253, 584.6112335297065, 604.2835667614313, 607.3289015637745, 607.5746977116037, 3673.632636736305, 3707.7404581679025, 3724.7392682511963, 3733.4213196954515, 3905.0, 97067.51466242624, 97173.51413242889, 97220.0, 101391.49304253432, 101845.49077254566, 83532.0, 85055.0, 87628.5618571903, 88039.55980220185, 88556.47269981995, 76328.0, 76891.0, 76966.6151669238, 78190.6090469544, 78717.0, 8008.677483529944, 8109.675612975415, 8135.79660508492, 8241.0, 8374.162583741578, 40375.59624403718, 40765.592344076176, 41489.792551037055, 41811.7909410451, 42047.36928946007, 60048.39951600428, 60553.39446605478, 60794.0, 62448.375516244254, 63570.68214658897, 11120.277181983145, 11175.0, 11238.887611124112, 11318.32090074598, 11557.13321500874, 12106.394680265776, 12118.757624847278, 12937.611871643865, 13126.212427254395, 13220.206787592775, 11505.250411894556, 11745.530178793095, 12212.69468263265, 12253.387330633612, 12623.179493332904, 10633.680989570325, 11508.251963622337, 12040.638780836589, 12100.273983561014, 12209.511619535475, 11278.887211127783, 11533.192676512563, 11626.302421854716, 11828.349440780496, 12002.699932501757, 9197.218236449977, 9497.382670126419, 9502.85745713801, 9549.418967887043, 10336.431496267778, 9586.472743998867, 9848.901510984799, 9999.400035997864, 10032.799344012932, 10105.44420056904], "value": 6587.776173753733, "unit": "score"}], "name": "dromaeo_css", "value": 6163.937127860773, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 115.0, 115.0, 117.0, 115.0, 115.0, 116.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 126.0, 176.0, 128.0, 129.0, 126.0, 142.0, 161.0, 127.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 160.0, 160.0, 160.0, 161.0, 161.0, 163.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 105.0, 79.0, 77.0, 77.0, 77.0, 117.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 112.0, 85.0, 85.0, 84.0, 105.0, 84.0, 84.0, 113.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 64.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 83.0, 83.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 142.0, 143.0, 137.0, 137.0, 138.0, 138.0, 178.0, 139.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 177.0, 182.0, 177.0, 180.0, 176.0, 175.0, 178.0, 176.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 73.0, 70.0, 71.0, 71.0, 70.0, 74.0, 70.0, 68.0], "value": 70.7, "unit": "score"}], "name": "kraken", "value": 1549.8, "alertThreshold": 2.0}]} 16:11:31 INFO - Return code: 0 16:11:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:11:31 INFO - # TBPL SUCCESS # 16:11:31 INFO - Running post-action listener: _resource_record_post_action 16:11:31 INFO - [mozharness: 2016-10-14 23:11:31.948774Z] Finished run-tests step (success) 16:11:31 INFO - Running post-run listener: _resource_record_post_run 16:11:32 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393850880; Read time: 12; Write time: 268040 16:11:32 INFO - TinderboxPrint: CPU usage
13.0% 16:11:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:11:32 INFO - TinderboxPrint: I/O write bytes / time
393,850,880 / 268,040 16:11:32 INFO - TinderboxPrint: CPU idle
8,344.3 (86.9%) 16:11:32 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 16:11:32 INFO - TinderboxPrint: Swap in / out
0 / 0 16:11:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102400000; Read time: 0; Write time: 96852 16:11:32 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291450880; Read time: 0; Write time: 171188 16:11:32 INFO - Running post-run listener: _upload_blobber_files 16:11:32 INFO - Blob upload gear active. 16:11:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:32 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 16:11:32 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:11:32 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:11:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:33 INFO - (blobuploader) - INFO - Done attempting. 16:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:34 INFO - (blobuploader) - INFO - Done attempting. 16:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:38 INFO - (blobuploader) - INFO - Done attempting. 16:11:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:38 INFO - Return code: 0 16:11:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a7169a295e228a5d06a604262cd01aedba5eb19f8589744be03b5b23c14ed60944a8701a233a073dc04ac338a4795ee146114b4677a51aea68d0959addd982b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4ffb9657cc14bbee6f3b8c22725fb6cb70342c756b84ee9dc9d9f7aa5f52e52d08834b178bf44866d25402ad14f1ff649d9895f6a7a778880b54dc1bdba2a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38054607c60fbc9d8d0e4e65c641b4cbf3308c552f5f6e76e2d443fcd661beef0c376ffc37715e22e1616779beeeb585a100ace521c4fc0a0e296567a9a4270b"} 16:11:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:38 INFO - Contents: 16:11:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a7169a295e228a5d06a604262cd01aedba5eb19f8589744be03b5b23c14ed60944a8701a233a073dc04ac338a4795ee146114b4677a51aea68d0959addd982b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4ffb9657cc14bbee6f3b8c22725fb6cb70342c756b84ee9dc9d9f7aa5f52e52d08834b178bf44866d25402ad14f1ff649d9895f6a7a778880b54dc1bdba2a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38054607c60fbc9d8d0e4e65c641b4cbf3308c552f5f6e76e2d443fcd661beef0c376ffc37715e22e1616779beeeb585a100ace521c4fc0a0e296567a9a4270b"} 16:11:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:38 INFO - Copying logs to upload dir... 16:11:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.414182 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 16:11:38.443773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:11:38.447118) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a7169a295e228a5d06a604262cd01aedba5eb19f8589744be03b5b23c14ed60944a8701a233a073dc04ac338a4795ee146114b4677a51aea68d0959addd982b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4ffb9657cc14bbee6f3b8c22725fb6cb70342c756b84ee9dc9d9f7aa5f52e52d08834b178bf44866d25402ad14f1ff649d9895f6a7a778880b54dc1bdba2a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38054607c60fbc9d8d0e4e65c641b4cbf3308c552f5f6e76e2d443fcd661beef0c376ffc37715e22e1616779beeeb585a100ace521c4fc0a0e296567a9a4270b"} build_url:https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011548 build_url: 'https://queue.taskcluster.net/v1/task/c7DZkE4YS7eEuTav0BDIXA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9a7169a295e228a5d06a604262cd01aedba5eb19f8589744be03b5b23c14ed60944a8701a233a073dc04ac338a4795ee146114b4677a51aea68d0959addd982b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c4ffb9657cc14bbee6f3b8c22725fb6cb70342c756b84ee9dc9d9f7aa5f52e52d08834b178bf44866d25402ad14f1ff649d9895f6a7a778880b54dc1bdba2a5d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38054607c60fbc9d8d0e4e65c641b4cbf3308c552f5f6e76e2d443fcd661beef0c376ffc37715e22e1616779beeeb585a100ace521c4fc0a0e296567a9a4270b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 16:11:38.472665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:11:38.473000) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1476485450.494353-711101223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 16:11:38.557563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:11:38.557880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 16:11:38.558166) ========= ========= Total master_lag: 0.17 =========