builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-057 starttime: 1479732278.63 results: success (0) buildid: 20161121015253 builduid: 46d1ce5c94784bcdad1aa52fc8429f40 revision: c7be1246b301 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.631497) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.631932) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.632248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.649870) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.650166) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 04:44:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.7M=0s 2016-11-21 04:44:40 (69.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149815 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.817918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.818629) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018962 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.872960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:38.873722) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c7be1246b301 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c7be1246b301 --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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 04:44:40,250 Setting DEBUG logging. 2016-11-21 04:44:40,250 attempt 1/10 2016-11-21 04:44:40,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c7be1246b301?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 04:44:40,575 unpacking tar archive at: mozilla-inbound-c7be1246b301/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:39.563975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:39.564339) ========= script_repo_revision: c7be1246b301 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:39.564783) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:39.565083) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 04:44:39.574131) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-21 04:44:39.574487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:44:41 INFO - MultiFileLogger online at 20161121 04:44:41 in /builds/slave/test 04:44:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:44:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:41 INFO - {'append_to_log': False, 04:44:41 INFO - 'base_work_dir': '/builds/slave/test', 04:44:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:44:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:41 INFO - 'branch': 'Mozilla-Inbound', 04:44:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:41 INFO - 'config_files': ('talos/linux_config.py',), 04:44:41 INFO - 'default_actions': ('clobber', 04:44:41 INFO - 'read-buildbot-config', 04:44:41 INFO - 'download-and-extract', 04:44:41 INFO - 'populate-webroot', 04:44:41 INFO - 'create-virtualenv', 04:44:41 INFO - 'install', 04:44:41 INFO - 'run-tests'), 04:44:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:41 INFO - 'download_minidump_stackwalk': True, 04:44:41 INFO - 'download_symbols': 'ondemand', 04:44:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:41 INFO - 'installer_path': 'installer.exe', 04:44:41 INFO - 'log_level': 'info', 04:44:41 INFO - 'log_name': 'talos', 04:44:41 INFO - 'log_to_console': True, 04:44:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:44:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:44:41 INFO - 'opt_config_files': (), 04:44:41 INFO - 'pip_index': False, 04:44:41 INFO - 'sps_profile': False, 04:44:41 INFO - 'sps_profile_interval': 0, 04:44:41 INFO - 'suite': 'dromaeojs', 04:44:41 INFO - 'system_bits': '32', 04:44:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:41 INFO - 'title': 'talos-linux64-ix-057', 04:44:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:41 INFO - 'use_talos_json': True, 04:44:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:41 INFO - 'work_dir': 'build'} 04:44:41 INFO - [mozharness: 2016-11-21 12:44:41.054499Z] Running clobber step. 04:44:41 INFO - Running pre-action listener: _resource_record_pre_action 04:44:41 INFO - Running main action method: clobber 04:44:41 INFO - rmtree: /builds/slave/test/build 04:44:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:42 INFO - Running post-action listener: _resource_record_post_action 04:44:42 INFO - [mozharness: 2016-11-21 12:44:42.042368Z] Finished clobber step (success) 04:44:42 INFO - [mozharness: 2016-11-21 12:44:42.042466Z] Running read-buildbot-config step. 04:44:42 INFO - Running pre-action listener: _resource_record_pre_action 04:44:42 INFO - Running main action method: read_buildbot_config 04:44:42 INFO - Using buildbot properties: 04:44:42 INFO - { 04:44:42 INFO - "project": "", 04:44:42 INFO - "product": "firefox", 04:44:42 INFO - "script_repo_revision": "production", 04:44:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:44:42 INFO - "repository": "", 04:44:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:44:42 INFO - "buildid": "20161121015253", 04:44:42 INFO - "pgo_build": "True", 04:44:42 INFO - "basedir": "/builds/slave/test", 04:44:42 INFO - "buildnumber": 2125, 04:44:42 INFO - "slavename": "talos-linux64-ix-057", 04:44:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:44:42 INFO - "platform": "ubuntu64_hw", 04:44:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:44:42 INFO - "branch": "mozilla-inbound", 04:44:42 INFO - "repo_path": "integration/mozilla-inbound", 04:44:42 INFO - "revision": "c7be1246b301", 04:44:42 INFO - "stage_platform": "linux64-pgo", 04:44:42 INFO - "builduid": "46d1ce5c94784bcdad1aa52fc8429f40", 04:44:42 INFO - "slavebuilddir": "test" 04:44:42 INFO - } 04:44:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 04:44:42 INFO - Running post-action listener: _resource_record_post_action 04:44:42 INFO - [mozharness: 2016-11-21 12:44:42.044911Z] Finished read-buildbot-config step (success) 04:44:42 INFO - [mozharness: 2016-11-21 12:44:42.044999Z] Running download-and-extract step. 04:44:42 INFO - Running pre-action listener: _resource_record_pre_action 04:44:42 INFO - Running main action method: download_and_extract 04:44:42 INFO - mkdir: /builds/slave/test/build/tests 04:44:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:42 INFO - trying https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:44:42 INFO - Downloading https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:44:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:44:42 INFO - Downloaded 1361 bytes. 04:44:42 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 04:44:42 INFO - Using the following test package requirements: 04:44:42 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:42 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:44:42 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:44:42 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'jsshell-linux-x86_64.zip'], 04:44:42 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:44:42 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 04:44:42 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:44:42 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:44:42 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:44:42 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 04:44:42 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:44:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:44:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:44:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:42 INFO - Fetch https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:44:43 INFO - Http code: 200 04:44:43 INFO - via: 1.1 1c6cc78b8ca6319854350cf7a741a470.cloudfront.net (CloudFront) 04:44:43 INFO - x-amz-cf-id: 7yBLHYJ_EunaJQUhEP3rdMdIRqOviDd_cK6qgEqfZMaRn1A9LsqTpg== 04:44:43 INFO - x-amz-version-id: _0gyJH8JQBVvOHMuSokkvwfaLRjEgYms 04:44:43 INFO - Expected file size: 21960899 04:44:43 INFO - Obtained file size: 21960899 04:44:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:44:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 04:44:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:44:47 INFO - Fetch https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:44:48 INFO - Http code: 200 04:44:48 INFO - via: 1.1 aa96a51fedae85199c643eb5c8eca4e4.cloudfront.net (CloudFront) 04:44:48 INFO - x-amz-cf-id: 81ReMe1EoUS33zWLhFD7E81_WRV5CZgLE8YZh1V1hmDJYtQAt0Nmsg== 04:44:48 INFO - x-amz-version-id: _0gyJH8JQBVvOHMuSokkvwfaLRjEgYms 04:44:48 INFO - Expected file size: 21960899 04:44:48 INFO - Obtained file size: 21960899 04:44:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 04:44:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:44:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:44:53 INFO - Http code: 200 04:44:53 INFO - via: 1.1 aa96a51fedae85199c643eb5c8eca4e4.cloudfront.net (CloudFront) 04:44:53 INFO - x-amz-cf-id: 064c7IaZ39TH_qAExJXmoSeBaGUeNTH1eROD4-KcMWAkLgxgNRaoLw== 04:44:53 INFO - x-amz-version-id: 7RQhD.EE0gtF0frxni3GxpiGeEYX3.AX 04:44:53 INFO - Expected file size: 14409392 04:44:53 INFO - Obtained file size: 14409392 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:53 INFO - trying https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:44:53 INFO - Downloading https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:44:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:44:57 INFO - Downloaded 59408748 bytes. 04:44:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:44:57 INFO - mkdir: /builds/slave/test/properties 04:44:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:57 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:57 INFO - Contents: 04:44:57 INFO - build_url:https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 04:44:59 INFO - Running post-action listener: _resource_record_post_action 04:44:59 INFO - Running post-action listener: set_extra_try_arguments 04:44:59 INFO - [mozharness: 2016-11-21 12:44:59.448565Z] Finished download-and-extract step (success) 04:44:59 INFO - [mozharness: 2016-11-21 12:44:59.448791Z] Running populate-webroot step. 04:44:59 INFO - Running pre-action listener: _resource_record_pre_action 04:44:59 INFO - Running main action method: populate_webroot 04:44:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:59 INFO - '--tppagecycles', 04:44:59 INFO - '7'], 04:44:59 INFO - 'tests': ['tsvgm']}}, 04:44:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['damp', 'tps']}, 04:44:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'tests': ['damp', 'tps']}, 04:44:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['dromaeo_dom']}, 04:44:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['basic_compositor_video']}, 04:44:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['a11yr', 04:44:59 INFO - 'ts_paint', 04:44:59 INFO - 'tpaint', 04:44:59 INFO - 'sessionrestore', 04:44:59 INFO - 'sessionrestore_no_auto_restore', 04:44:59 INFO - 'tabpaint']}, 04:44:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['tsvgx', 04:44:59 INFO - 'tsvgr_opacity', 04:44:59 INFO - 'tart', 04:44:59 INFO - 'tscrollx', 04:44:59 INFO - 'cart']}, 04:44:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:59 INFO - 'tsvgr_opacity', 04:44:59 INFO - 'tart', 04:44:59 INFO - 'tscrollx', 04:44:59 INFO - 'cart']}, 04:44:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'talos_options': ['--disable-e10s'], 04:44:59 INFO - 'tests': ['tp5o']}, 04:44:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'talos_options': ['--disable-e10s', 04:44:59 INFO - '--xperf_path', 04:44:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:59 INFO - 'tests': ['tp5n']}, 04:44:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:59 INFO - 'talos_options': ['--xperf_path', 04:44:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:59 INFO - 'tests': ['tp5n']}}, 04:44:59 INFO - 'talos.zip': {'path': '', 04:44:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:59 INFO - Running post-action listener: _resource_record_post_action 04:44:59 INFO - [mozharness: 2016-11-21 12:44:59.469296Z] Finished populate-webroot step (success) 04:44:59 INFO - [mozharness: 2016-11-21 12:44:59.469383Z] Running create-virtualenv step. 04:44:59 INFO - Running pre-action listener: _resource_record_pre_action 04:44:59 INFO - Running main action method: create_virtualenv 04:44:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:59 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 04:44:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:59 INFO - Using real prefix '/usr' 04:44:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:45:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:45:02 INFO - Installing pip.................done. 04:45:02 INFO - Return code: 0 04:45:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:45:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:45:02 INFO - Reading from file tmpfile_stdout 04:45:02 INFO - Output received: 04:45:02 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) 04:45:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:45:02 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')]} 04:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:02 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')]} 04:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:02 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:02 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 04:45:02 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 04:45:02 INFO - Using env: {'DISPLAY': ':0', 04:45:02 INFO - 'HOME': '/home/cltbld', 04:45:02 INFO - 'LANG': 'en_US.UTF-8', 04:45:02 INFO - 'LANGUAGE': 'en_US:en', 04:45:02 INFO - 'LOGNAME': 'cltbld', 04:45:02 INFO - 'MAIL': '/var/mail/cltbld', 04:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:02 INFO - 'MOZ_NO_REMOTE': '1', 04:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:02 INFO - 'NO_EM_RESTART': '1', 04:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:02 INFO - 'PWD': '/builds/slave/test', 04:45:02 INFO - 'SHELL': '/bin/bash', 04:45:02 INFO - 'SHLVL': '1', 04:45:02 INFO - 'TERM': 'linux', 04:45:02 INFO - 'TMOUT': '86400', 04:45:02 INFO - 'USER': 'cltbld', 04:45:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:02 INFO - '_': '/tools/buildbot/bin/python'} 04:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:02 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 04:45:02 INFO - Cleaning up... 04:45:02 INFO - Return code: 0 04:45:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:45:02 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')]} 04:45:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:02 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')]} 04:45:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:02 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:02 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 04:45:02 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 04:45:02 INFO - Using env: {'DISPLAY': ':0', 04:45:02 INFO - 'HOME': '/home/cltbld', 04:45:02 INFO - 'LANG': 'en_US.UTF-8', 04:45:02 INFO - 'LANGUAGE': 'en_US:en', 04:45:02 INFO - 'LOGNAME': 'cltbld', 04:45:02 INFO - 'MAIL': '/var/mail/cltbld', 04:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:02 INFO - 'MOZ_NO_REMOTE': '1', 04:45:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:02 INFO - 'NO_EM_RESTART': '1', 04:45:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:02 INFO - 'PWD': '/builds/slave/test', 04:45:02 INFO - 'SHELL': '/bin/bash', 04:45:02 INFO - 'SHLVL': '1', 04:45:02 INFO - 'TERM': 'linux', 04:45:02 INFO - 'TMOUT': '86400', 04:45:02 INFO - 'USER': 'cltbld', 04:45:02 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:02 INFO - '_': '/tools/buildbot/bin/python'} 04:45:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:02 INFO - Downloading/unpacking psutil>=3.1.1 04:45:02 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 04:45:02 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 04:45:02 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 04:45:02 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 04:45:02 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 04:45:02 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 04:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:45:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:04 INFO - Installing collected packages: psutil 04:45:04 INFO - Running setup.py install for psutil 04:45:04 INFO - building 'psutil._psutil_linux' extension 04:45:04 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 04:45:05 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 04:45:05 INFO - building 'psutil._psutil_posix' extension 04:45:05 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 04:45:05 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 04:45:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:45:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:45:05 INFO - Successfully installed psutil 04:45:05 INFO - Cleaning up... 04:45:05 INFO - Return code: 0 04:45:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:45:05 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')]} 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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')]} 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:05 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:05 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 04:45:05 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 04:45:05 INFO - Using env: {'DISPLAY': ':0', 04:45:05 INFO - 'HOME': '/home/cltbld', 04:45:05 INFO - 'LANG': 'en_US.UTF-8', 04:45:05 INFO - 'LANGUAGE': 'en_US:en', 04:45:05 INFO - 'LOGNAME': 'cltbld', 04:45:05 INFO - 'MAIL': '/var/mail/cltbld', 04:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:05 INFO - 'MOZ_NO_REMOTE': '1', 04:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:05 INFO - 'NO_EM_RESTART': '1', 04:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:05 INFO - 'PWD': '/builds/slave/test', 04:45:05 INFO - 'SHELL': '/bin/bash', 04:45:05 INFO - 'SHLVL': '1', 04:45:05 INFO - 'TERM': 'linux', 04:45:05 INFO - 'TMOUT': '86400', 04:45:05 INFO - 'USER': 'cltbld', 04:45:05 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:05 INFO - '_': '/tools/buildbot/bin/python'} 04:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:05 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 04:45:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:45:07 INFO - Installing collected packages: mozsystemmonitor 04:45:07 INFO - Running setup.py install for mozsystemmonitor 04:45:07 INFO - Successfully installed mozsystemmonitor 04:45:07 INFO - Cleaning up... 04:45:07 INFO - Return code: 0 04:45:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:45:07 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')]} 04:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:07 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')]} 04:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:07 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:07 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 04:45:07 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 04:45:07 INFO - Using env: {'DISPLAY': ':0', 04:45:07 INFO - 'HOME': '/home/cltbld', 04:45:07 INFO - 'LANG': 'en_US.UTF-8', 04:45:07 INFO - 'LANGUAGE': 'en_US:en', 04:45:07 INFO - 'LOGNAME': 'cltbld', 04:45:07 INFO - 'MAIL': '/var/mail/cltbld', 04:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:07 INFO - 'MOZ_NO_REMOTE': '1', 04:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:07 INFO - 'NO_EM_RESTART': '1', 04:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:07 INFO - 'PWD': '/builds/slave/test', 04:45:07 INFO - 'SHELL': '/bin/bash', 04:45:07 INFO - 'SHLVL': '1', 04:45:07 INFO - 'TERM': 'linux', 04:45:07 INFO - 'TMOUT': '86400', 04:45:07 INFO - 'USER': 'cltbld', 04:45:07 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:07 INFO - '_': '/tools/buildbot/bin/python'} 04:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:07 INFO - Downloading/unpacking jsonschema==2.5.1 04:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:45:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:10 INFO - Downloading functools32-3.2.3-2.tar.gz 04:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:45:10 INFO - warning: no files found matching '*.txt' 04:45:10 INFO - no previously-included directories found matching 'build' 04:45:10 INFO - no previously-included directories found matching 'dist' 04:45:10 INFO - no previously-included directories found matching '.git*' 04:45:10 INFO - Installing collected packages: jsonschema, functools32 04:45:10 INFO - Running setup.py install for functools32 04:45:10 INFO - warning: no files found matching '*.txt' 04:45:10 INFO - no previously-included directories found matching 'build' 04:45:10 INFO - no previously-included directories found matching 'dist' 04:45:10 INFO - no previously-included directories found matching '.git*' 04:45:10 INFO - Successfully installed jsonschema functools32 04:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:10 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 04:45:10 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 04:45:10 INFO - Using env: {'DISPLAY': ':0', 04:45:10 INFO - 'HOME': '/home/cltbld', 04:45:10 INFO - 'LANG': 'en_US.UTF-8', 04:45:10 INFO - 'LANGUAGE': 'en_US:en', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MAIL': '/var/mail/cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SHLVL': '1', 04:45:10 INFO - 'TERM': 'linux', 04:45:10 INFO - 'TMOUT': '86400', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - '_': '/tools/buildbot/bin/python'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:10 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 04:45:10 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 04:45:10 INFO - Using env: {'DISPLAY': ':0', 04:45:10 INFO - 'HOME': '/home/cltbld', 04:45:10 INFO - 'LANG': 'en_US.UTF-8', 04:45:10 INFO - 'LANGUAGE': 'en_US:en', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MAIL': '/var/mail/cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SHLVL': '1', 04:45:10 INFO - 'TERM': 'linux', 04:45:10 INFO - 'TMOUT': '86400', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - '_': '/tools/buildbot/bin/python'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:45:10 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 04:45:10 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 04:45:10 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 04:45:10 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 04:45:10 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 04:45:10 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 04:45:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:45:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:45:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 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 04:45:13 INFO - Downloading docopt-0.6.1.tar.gz 04:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:45:13 INFO - Installing collected packages: blobuploader, requests, docopt 04:45:13 INFO - Running setup.py install for blobuploader 04:45:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:45:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:45:13 INFO - Running setup.py install for requests 04:45:14 INFO - Running setup.py install for docopt 04:45:14 INFO - Successfully installed blobuploader requests docopt 04:45:14 INFO - Cleaning up... 04:45:14 INFO - Return code: 0 04:45:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:14 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:14 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 04:45:14 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 04:45:14 INFO - Using env: {'DISPLAY': ':0', 04:45:14 INFO - 'HOME': '/home/cltbld', 04:45:14 INFO - 'LANG': 'en_US.UTF-8', 04:45:14 INFO - 'LANGUAGE': 'en_US:en', 04:45:14 INFO - 'LOGNAME': 'cltbld', 04:45:14 INFO - 'MAIL': '/var/mail/cltbld', 04:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:14 INFO - 'MOZ_NO_REMOTE': '1', 04:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:14 INFO - 'NO_EM_RESTART': '1', 04:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:14 INFO - 'PWD': '/builds/slave/test', 04:45:14 INFO - 'SHELL': '/bin/bash', 04:45:14 INFO - 'SHLVL': '1', 04:45:14 INFO - 'TERM': 'linux', 04:45:14 INFO - 'TMOUT': '86400', 04:45:14 INFO - 'USER': 'cltbld', 04:45:14 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:14 INFO - '_': '/tools/buildbot/bin/python'} 04:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:14 INFO - Running setup.py (path:/tmp/pip-P5_C99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:14 INFO - Running setup.py (path:/tmp/pip-BKVofE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:14 INFO - Running setup.py (path:/tmp/pip-I4BQwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:14 INFO - Running setup.py (path:/tmp/pip-ip4ZqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:14 INFO - Running setup.py (path:/tmp/pip-kWvSUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:14 INFO - Running setup.py (path:/tmp/pip-SFohOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:15 INFO - Running setup.py (path:/tmp/pip-j0mfBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:15 INFO - Running setup.py (path:/tmp/pip-lGO5nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:15 INFO - Running setup.py (path:/tmp/pip-3SvnNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:15 INFO - Running setup.py (path:/tmp/pip-iqALQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:15 INFO - Running setup.py (path:/tmp/pip-OzQoK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:15 INFO - Running setup.py (path:/tmp/pip-Jx2Q5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:15 INFO - Running setup.py (path:/tmp/pip-nb7XlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:15 INFO - Running setup.py (path:/tmp/pip-S_mZng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:15 INFO - Running setup.py (path:/tmp/pip-OK4ADO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:15 INFO - Running setup.py (path:/tmp/pip-s531oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:15 INFO - Running setup.py (path:/tmp/pip-n1TMJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:15 INFO - Running setup.py install for manifestparser 04:45:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:15 INFO - Running setup.py install for mozcrash 04:45:16 INFO - Running setup.py install for mozdebug 04:45:16 INFO - Running setup.py install for mozdevice 04:45:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for mozfile 04:45:16 INFO - Running setup.py install for mozhttpd 04:45:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for mozinfo 04:45:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for mozInstall 04:45:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for mozleak 04:45:16 INFO - Running setup.py install for mozlog 04:45:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for moznetwork 04:45:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:16 INFO - Running setup.py install for mozprocess 04:45:17 INFO - Running setup.py install for mozprofile 04:45:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:17 INFO - Running setup.py install for mozrunner 04:45:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:17 INFO - Running setup.py install for mozscreenshot 04:45:17 INFO - Running setup.py install for moztest 04:45:17 INFO - Running setup.py install for mozversion 04:45:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:17 INFO - Cleaning up... 04:45:17 INFO - Return code: 0 04:45:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:17 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:17 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 04:45:17 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 04:45:17 INFO - Using env: {'DISPLAY': ':0', 04:45:17 INFO - 'HOME': '/home/cltbld', 04:45:17 INFO - 'LANG': 'en_US.UTF-8', 04:45:17 INFO - 'LANGUAGE': 'en_US:en', 04:45:17 INFO - 'LOGNAME': 'cltbld', 04:45:17 INFO - 'MAIL': '/var/mail/cltbld', 04:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:17 INFO - 'MOZ_NO_REMOTE': '1', 04:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:17 INFO - 'NO_EM_RESTART': '1', 04:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:17 INFO - 'PWD': '/builds/slave/test', 04:45:17 INFO - 'SHELL': '/bin/bash', 04:45:17 INFO - 'SHLVL': '1', 04:45:17 INFO - 'TERM': 'linux', 04:45:17 INFO - 'TMOUT': '86400', 04:45:17 INFO - 'USER': 'cltbld', 04:45:17 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:17 INFO - '_': '/tools/buildbot/bin/python'} 04:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:17 INFO - Running setup.py (path:/tmp/pip-DVocTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:17 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)) 04:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:17 INFO - Running setup.py (path:/tmp/pip-oteg_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:17 INFO - Running setup.py (path:/tmp/pip-206xDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:18 INFO - Running setup.py (path:/tmp/pip-hFVblu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:18 INFO - Running setup.py (path:/tmp/pip-J_fGkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:18 INFO - Running setup.py (path:/tmp/pip-pNwFoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:18 INFO - Running setup.py (path:/tmp/pip-xBaCxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:18 INFO - Running setup.py (path:/tmp/pip-7Mwp0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:18 INFO - Running setup.py (path:/tmp/pip-OxBu10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:18 INFO - Running setup.py (path:/tmp/pip-yMjcAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:18 INFO - Running setup.py (path:/tmp/pip-KcZo9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:18 INFO - Running setup.py (path:/tmp/pip-p7nTWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:18 INFO - Running setup.py (path:/tmp/pip-Ck8Zf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:18 INFO - Running setup.py (path:/tmp/pip-QlK0Kj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:18 INFO - Running setup.py (path:/tmp/pip-PbslZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:18 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)) 04:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:18 INFO - Running setup.py (path:/tmp/pip-gNlNwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:19 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)) 04:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:19 INFO - Running setup.py (path:/tmp/pip-1wWq8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:19 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)) 04:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:19 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)) 04:45:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:19 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45: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 04:45:21 INFO - Downloading blessings-1.6.tar.gz 04:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:21 INFO - Installing collected packages: blessings 04:45:21 INFO - Running setup.py install for blessings 04:45:21 INFO - Successfully installed blessings 04:45:21 INFO - Cleaning up... 04:45:21 INFO - Return code: 0 04:45:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:21 INFO - Reading from file tmpfile_stdout 04:45:21 INFO - Current package versions: 04:45:21 INFO - argparse == 1.2.1 04:45:21 INFO - blessings == 1.6 04:45:21 INFO - blobuploader == 1.2.4 04:45:21 INFO - docopt == 0.6.1 04:45:21 INFO - functools32 == 3.2.3-2 04:45:21 INFO - jsonschema == 2.5.1 04:45:21 INFO - manifestparser == 1.1 04:45:21 INFO - mozInstall == 1.12 04:45:21 INFO - mozcrash == 1.0 04:45:21 INFO - mozdebug == 0.1 04:45:21 INFO - mozdevice == 0.49 04:45:21 INFO - mozfile == 1.2 04:45:21 INFO - mozhttpd == 0.7 04:45:21 INFO - mozinfo == 0.9 04:45:21 INFO - mozleak == 0.1 04:45:21 INFO - mozlog == 3.4 04:45:21 INFO - moznetwork == 0.27 04:45:21 INFO - mozprocess == 0.23 04:45:21 INFO - mozprofile == 0.28 04:45:21 INFO - mozrunner == 6.13 04:45:21 INFO - mozscreenshot == 0.1 04:45:21 INFO - mozsystemmonitor == 0.3 04:45:21 INFO - moztest == 0.7 04:45:21 INFO - mozversion == 1.4 04:45:21 INFO - psutil == 3.1.1 04:45:21 INFO - requests == 1.2.3 04:45:21 INFO - wsgiref == 0.1.2 04:45:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:21 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')]} 04:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:21 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')]} 04:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:21 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:21 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 04:45:21 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 04:45:21 INFO - Using env: {'DISPLAY': ':0', 04:45:21 INFO - 'HOME': '/home/cltbld', 04:45:21 INFO - 'LANG': 'en_US.UTF-8', 04:45:21 INFO - 'LANGUAGE': 'en_US:en', 04:45:21 INFO - 'LOGNAME': 'cltbld', 04:45:21 INFO - 'MAIL': '/var/mail/cltbld', 04:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:21 INFO - 'MOZ_NO_REMOTE': '1', 04:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:21 INFO - 'NO_EM_RESTART': '1', 04:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:21 INFO - 'PWD': '/builds/slave/test', 04:45:21 INFO - 'SHELL': '/bin/bash', 04:45:21 INFO - 'SHLVL': '1', 04:45:21 INFO - 'TERM': 'linux', 04:45:21 INFO - 'TMOUT': '86400', 04:45:21 INFO - 'USER': 'cltbld', 04:45:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:21 INFO - '_': '/tools/buildbot/bin/python'} 04:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 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)) 04:45:21 INFO - Cleaning up... 04:45:21 INFO - Return code: 0 04:45:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:21 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')]} 04:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:21 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')]} 04:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:21 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 0x7f0b44c48e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27dfb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x297b130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', '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 04:45:21 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 04:45:21 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 04:45:21 INFO - Using env: {'DISPLAY': ':0', 04:45:21 INFO - 'HOME': '/home/cltbld', 04:45:21 INFO - 'LANG': 'en_US.UTF-8', 04:45:21 INFO - 'LANGUAGE': 'en_US:en', 04:45:21 INFO - 'LOGNAME': 'cltbld', 04:45:21 INFO - 'MAIL': '/var/mail/cltbld', 04:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:21 INFO - 'MOZ_NO_REMOTE': '1', 04:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:21 INFO - 'NO_EM_RESTART': '1', 04:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:21 INFO - 'PWD': '/builds/slave/test', 04:45:21 INFO - 'SHELL': '/bin/bash', 04:45:21 INFO - 'SHLVL': '1', 04:45:21 INFO - 'TERM': 'linux', 04:45:21 INFO - 'TMOUT': '86400', 04:45:21 INFO - 'USER': 'cltbld', 04:45:21 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:21 INFO - '_': '/tools/buildbot/bin/python'} 04:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:21 INFO - Cleaning up... 04:45:21 INFO - Return code: 0 04:45:21 INFO - Running post-action listener: _resource_record_post_action 04:45:21 INFO - Running post-action listener: _start_resource_monitoring 04:45:22 INFO - Starting resource monitoring. 04:45:22 INFO - [mozharness: 2016-11-21 12:45:22.002756Z] Finished create-virtualenv step (success) 04:45:22 INFO - [mozharness: 2016-11-21 12:45:22.003235Z] Running install step. 04:45:22 INFO - Running pre-action listener: _resource_record_pre_action 04:45:22 INFO - Running main action method: install 04:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:22 INFO - Reading from file tmpfile_stdout 04:45:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:22 INFO - Reading from file tmpfile_stdout 04:45:22 INFO - Output received: 04:45:22 INFO - Usage: mozinstall [options] installer 04:45:22 INFO - Options: 04:45:22 INFO - -h, --help show this help message and exit 04:45:22 INFO - -d DEST, --destination=DEST 04:45:22 INFO - Directory to install application into. [default: 04:45:22 INFO - "/builds/slave/test"] 04:45:22 INFO - --app=APP Application being installed. [default: firefox] 04:45:22 INFO - mkdir: /builds/slave/test/build/application 04:45:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:45:39 INFO - Reading from file tmpfile_stdout 04:45:39 INFO - Output received: 04:45:39 INFO - /builds/slave/test/build/application/firefox/firefox 04:45:39 INFO - Running post-action listener: _resource_record_post_action 04:45:39 INFO - [mozharness: 2016-11-21 12:45:39.174819Z] Finished install step (success) 04:45:39 INFO - [mozharness: 2016-11-21 12:45:39.175058Z] Running run-tests step. 04:45:39 INFO - Running pre-action listener: _resource_record_pre_action 04:45:39 INFO - Running main action method: run_tests 04:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:39 INFO - Python 2.7.3 04:45:39 INFO - Return code: 0 04:45:39 INFO - grabbing minidump binary from tooltool 04:45:39 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')]} 04:45:39 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 0x2a09fc0>, '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 0x2a0aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0b350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:39 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 04:45:39 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 04:45:39 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 04:45:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:39 INFO - Return code: 0 04:45:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:45:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:45:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 04:45:39 INFO - Using env: {'DISPLAY': ':0', 04:45:39 INFO - 'HOME': '/home/cltbld', 04:45:39 INFO - 'LANG': 'en_US.UTF-8', 04:45:39 INFO - 'LANGUAGE': 'en_US:en', 04:45:39 INFO - 'LOGNAME': 'cltbld', 04:45:39 INFO - 'MAIL': '/var/mail/cltbld', 04:45:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:39 INFO - 'MOZ_NO_REMOTE': '1', 04:45:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:45:39 INFO - 'NO_EM_RESTART': '1', 04:45:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:39 INFO - 'PWD': '/builds/slave/test', 04:45:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:39 INFO - 'SHELL': '/bin/bash', 04:45:39 INFO - 'SHLVL': '1', 04:45:39 INFO - 'TERM': 'linux', 04:45:39 INFO - 'TMOUT': '86400', 04:45:39 INFO - 'USER': 'cltbld', 04:45:39 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997', 04:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:39 INFO - '_': '/tools/buildbot/bin/python'} 04:45:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 04:45:39 INFO - mozversion application_buildid: 20161121015253 04:45:39 INFO - mozversion application_changeset: c7be1246b30124324539133b4e10645bc6b5155f 04:45:39 INFO - mozversion application_display_name: Nightly 04:45:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:39 INFO - mozversion application_name: Firefox 04:45:39 INFO - mozversion application_remotingname: firefox 04:45:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:45:39 INFO - mozversion application_vendor: Mozilla 04:45:39 INFO - mozversion application_version: 53.0a1 04:45:39 INFO - mozversion platform_buildid: 20161121015253 04:45:39 INFO - mozversion platform_changeset: c7be1246b30124324539133b4e10645bc6b5155f 04:45:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:45:39 INFO - mozversion platform_version: 53.0a1 04:45:39 INFO - using testdate: 1479732339 04:45:39 INFO - actual date: 1479732339 04:45:39 INFO - starting webserver on 'localhost:53481' 04:45:39 INFO - SUITE-START | Running 2 tests 04:45:39 INFO - TEST-START | dromaeo_css 04:45:39 INFO - operating with platform_type : linux_ 04:45:39 INFO - Initialising browser for dromaeo_css test... 04:45:39 INFO - TEST-INFO | started process 6689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqayVah/profile http://localhost:53481/getInfo.html) 04:45:43 INFO - PROCESS | 6689 | __metrics Screen width/height:1600/1200 04:45:43 INFO - PROCESS | 6689 | colorDepth:24 04:45:43 INFO - PROCESS | 6689 | Browser inner width/height: 1024/697 04:45:43 INFO - PROCESS | 6689 | __metrics 04:45:44 INFO - PROCESS | 6689 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:44 INFO - PROCESS | 6689 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:45 INFO - PROCESS | 6689 | console.error: PushService: 04:45:45 INFO - PROCESS | 6689 | stateChangeProcessEnqueue: Error transitioning state 04:45:45 INFO - PROCESS | 6689 | UnknownError 04:45:45 INFO - TEST-INFO | 6689: exit 0 04:45:45 INFO - Browser initialized. 04:45:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:45 INFO - TEST-INFO | started process 6771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqayVah/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:57 INFO - PROCESS | 6771 | RSS: Main: 173379584 04:45:57 INFO - PROCESS | 6771 | 04:46:49 INFO - PROCESS | 6771 | 1479732409186 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] 04:49:00 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53481/tests/dromaeo/cssquery-ext.html) 04:49:01 INFO - PROCESS | 6771 | RSS: Main: 291971072 04:49:01 INFO - PROCESS | 6771 | 04:52:04 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-ext.html (next: http://localhost:53481/tests/dromaeo/cssquery-jquery.html) 04:52:04 INFO - PROCESS | 6771 | RSS: Main: 276451328 04:52:04 INFO - PROCESS | 6771 | 04:55:07 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53481/tests/dromaeo/cssquery-mootools.html) 04:55:07 INFO - PROCESS | 6771 | RSS: Main: 218705920 04:55:07 INFO - PROCESS | 6771 | 04:58:09 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53481/tests/dromaeo/cssquery-prototype.html) 04:58:10 INFO - PROCESS | 6771 | RSS: Main: 254631936 04:58:10 INFO - PROCESS | 6771 | 05:01:13 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53481/tests/dromaeo/cssquery-yui.html) 05:01:14 INFO - PROCESS | 6771 | RSS: Main: 216997888 05:01:14 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | Cycle 1(1): loaded http://localhost:53481/tests/dromaeo/cssquery-yui.html (next: http://localhost:53481/tests/dromaeo/cssquery-dojo.html) 05:04:16 INFO - PROCESS | 6771 | RSS: Main: 331866112 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | __start_tp_report 05:04:16 INFO - PROCESS | 6771 | _x_x_mozilla_page_load 05:04:16 INFO - PROCESS | 6771 | _x_x_mozilla_page_load_details 05:04:16 INFO - PROCESS | 6771 | |i|pagename|runs| 05:04:16 INFO - PROCESS | 6771 | |0;dojo.html;3031.605891234139;3065.586145870307;3107.3940581586585;3122.0321700272902;3125.5780469636607;5328.413874473805;5349.625526213166;5402.567794576435;5433.103537916249;5435.537979271761;5405.621606487547;5428.0500912340285;5500;5527.751251193696;5572.080606699889;4921.311016457699;4945.109880221558;4986.825461108862;5019.723915184682;5042.117629414856;4975.850724478253;5037.924431133536;5091.287219789232;5100.464451232623;5123.385193776733;4790.065937142259;5030.2957585938;5032.899342013139;5075.467075957026;5131.615128865331;4806.327114204014;4894.388201474816;4899.436564795059;4900.730459824708;4901.362822833044;4855.393075865517;4867.440244371872;4870.245112007645;4876.585490233334;4880.463149053601;5259.368875734898;5304.920426193572;5322.547583455411;5331.920021199685;5333.653312534673;5685;5685.971570142165;5687.914681279784;5691.8292451226525;5693.544516438675;5868.794592189253;5877.67672777997;5894.941050589482;5954.732037058343;5975;5458.1266997280245;5509.256250406224;5515.448455154533;5515.806946756925;5552.944470555283;6046.667433291212;6047.12316714074;6050.667213303311;6051.878962420727;6051.939480605138;5596.720163991784;5609.046462101453;5707.914381284284;5754.079347304411;5787.594868359174;5922.763089476459;5923.703814809242;5924.4667979882015;5925.911111333334;5952.255968003999;5881.529477641779;5892.587518873637;5897.587168898136;5904.7342869570975;5904.940950590439;5728.742206600713;5759.992001399738;5765.711714414262;5918.348981612019;5955.970220148958;4433.334999749999;4433.645308375322;4434.600885920218;4463.799129039201;4466.932996005063;3937.9803100984313;3947.289487892207;3952.4268980997595;3973.523177218752;3979.9801000994808;5552.056150454432;5564.721763911788;5569.192467092249;5585.245991791137;5608.074667679787;5667.149927510906;5678.97160514203;5906;5908.793192238337;5972.970135149297;5535.529479994246;5577.386487486373;5592.664440133523;5612.354579223442;5635.21107045014;4860.684055536379;4906.484819094015;4909.337239472697;4922.138625740481;4949;5879.764809407576;5881.911771323519;5943.673097979653;6012.699365031731;6020.57855950088;5833.562482813721;5869.735861886311;5875.6474611523445;5929.851753706192;5949.196858424058;6059.484943779828;6062.211912451353;6071.635701857726;6071.848203794941;6074.453299203093;5537.307836520435;5788.623739456922;5791.420857914175;5797.449242321973;5799.3040835100055;5649.943500564942;5741.569382296428;5744.626599271034;5771.68255745938;5825.679587622722;5678.517326027334;5682.062459694104;5684;5684.317881854038;5687.090065589486;5588.273524441796;5639.2668953035845;5651.954388438152;5654.830355089354;5659;5524.392316845064;5615.213870058276;5652.604317697722;5657.32112146545;5764.933487304862;5788.479036886701;5805.071188609802;5809.186713860147;5821.38875418075;5825.737841797045;5493.835184944458;5529.419410961952;5532.972335138298;5686.118651609007;5697.54419646419 05:04:16 INFO - PROCESS | 6771 | |1;ext.html;555.7686729853385;578.8929048126096;593.5815250248576;615.7013848283582;647.4496677823847;32988.17529561759;42449.78775106128;43059;43102.784486077566;46444.76777616107;44579.33131003029;44587;45132.77433612836;45187.32219016709;45226;7719.807004824868;8549.10234425384;8794.648214071429;8795.912040879606;8837.911620883806;7761.495502792329;10228.33515821473;10418.062374386303;10480.47597620116;10762.408067556282;10669.306495077833;10721;10733.677989660322;10738.731531711692;10744.516496757626;10454.32046916948;10491.790164196711;10500.579976800918;10501.4224217668;10518.263721539495;10435.113015393701;10444;10496.21278404115;10500.159987201081;10521.316114452613;40908.1818363631;41094.178116437804;41183.7940810297;41248.38127428061;41335.379969300484;3445.8621655133766;3499.4750787382095;3554.0937061049526;3668.5414323209598;3847.5190601174854;30835.229119271975;31384;31389.843050784828;31424.214394640087;31542;4142.792860357;4258.787060646955;4262.50981137167;4332.761698106603;4402.427684401007;340707;341055;341149.9999999975;341425;341522;34168.145796354795;58045.709771451715;58112;58227.4177258222;58251.41748582545;35830.283394331964;37014.44478332827;37483.06292342713;37988.43017354742;38035.52769070057;14985;15194.696106077816;15202.543923682308;15205;15212.653216292398;11341.829872551918;11656.88343116558;12069.758604827854;12498.687532811753;12590.496380144692;8445.1977062179;8579.613917373734;8658.91341086581;8672.56637168139;8735.737927862174;3306.470964645645;3333.516640087222;3339.398908196548;3345.2305969627123;3362.6973572378115;992.3450522655013;1017.2523195451338;1042.7393151712072;1102.0247081333077;1102.72431892027;31219.21951951174;31883.681163188536;32015.51976720351;32239.35521289561;32586.837065814994;1080.4543705428866;1088.357868857378;1105.2926127278547;1145.6219447582278;1174.4656181437426;15982.120983346027;16663.750043749355;16850.91574542144;16860.156992150343;16981.83018169827;569574;578251;578528;578767;579640;39942.800285998965;40028.39957400641;40094.599054009086;40157.196856063296;40211.39682904759;1209.9334536600395;1254.5044707340548;1289.9806502902652;1345.2668295778824;1345.4349173347218;28422.573661394683;32443.513347300282;32564.348713025134;32751.672483274862;33273.33453330871;48140.27789583089;48708.756456217496;48980.51019489759;49154;49168;371932;373619;374822;374951;375260;27627.30931726723;27741.583876241468;28310.292242694097;28575;29242.561361579166;43660.56339436565;45792.77103614461;46349;46497.07005859932;46575.76712116418;38476.80761596174;39804.60195398009;40194;40409.19181616292;41441.58558414498;39463.60536394599;39502.2099558013;40920.18159636731;40951;41395.379069314586;39334.40998384969;39877.60122398739;40061.79969100136;40571.725675663154;40597;33836.32327353489;35758.60293272135;36354.818225908704;36446.27107457783;36461.63538364582;22861.54276914419;22975.540489190458;23269;23405.882970585037;23419.765802341757 05:04:16 INFO - PROCESS | 6771 | |2;jquery.html;374.0648379052369;387.94568760373534;397.6520544523541;402.27791114948667;419.15362826748185;13163.6709082273;15124.092554446726;16371.590710232234;18744.536631418043;19060.61878762424;18454.354097606585;19004;19023.143958521865;19068.04659767013;19232.13455394507;5489.204065410513;5735.827925162252;5736.942630573682;5740.138979153139;5740.282464691913;4588.678792484528;6407.615543067408;6443.420092191702;6443.613383197;6449.322821103787;6133.386661333876;6351.555391122623;6391.776287829927;6404.48764098871;6408.903866441984;6281.748730050793;6321.905171422432;6322.336154703758;6356.523260755462;6356.745730170787;5421.674699518042;5613.747381367848;5618.213450116987;5649.887002259973;5650.180723795027;22850.42873928165;22930.42673933165;23206.698387813543;23247.767522324728;23642.763572364227;2273.499830037389;2287.0737351372723;2367.763223677636;2632.670916135483;2828.123281782654;14368.64078398038;14477;14709.55871323862;14714.779278310834;15180.696386072217;1845.5293900055535;1926.1428664244418;1930.2279088364626;1944.980550194494;2009.0758251204463;80207;80411.5979420105;80480.19519804844;81890.18109818886;83710.58144709299;10440.947795260976;10576.682699519026;10800.675979720621;10909.563617455371;10920.617778377718;14780.63048423798;14839.777403338958;14972.625684357978;14990.550283491513;14997;7887.487313324616;7956.005499312586;8015.198480152055;8235.341172706288;8245.13426090264;7525.8118547035665;7756.728514501965;7774.844503109906;8037.718679846294;8043.959780201179;6420.807375778734;6436.581622194542;6461.741530338733;6580.539362244597;6644.568103073285;1854.2768320355071;1865.7947625761155;1870.4762666453414;1926.3931861463593;1935.6032013437211;976.702105857706;999.2006394884064;1025.2823023883311;1071.6624263357019;1117.5864929975799;18734.625307493774;19225;19957.900210499145;19986.20055197776;19999.800002000084;976.3165783951263;1004.7488127968008;1023.6621914768109;1044.3368461027303;1069.5187165775433;10145.64490242838;11206.327620342805;11302.604408845651;11335.093192544577;11354;486361;490085;503841;504568;505427;80956;81642;83702;84075;84089;936.6768464879469;961.9374740641836;978.3298440568234;984.2224642532462;991.9851202231972;16927.830721692626;17209.56976075558;17798.377056803467;17847.196876140344;17908.820911790714;38657.42013869851;39667.60332396639;39948;40297.59702402938;40960;51404.48595513997;51726;52256.73871630617;52318.215226770866;52475.47524524706;7857.253560911704;8264.545450000307;8286.46138001028;8365.707200247962;8519;12237.042073268234;12802.423890925116;12912;12978.675533111747;13034.283114428417;11294.322340659586;11436.142289328167;11446.713832154262;11804.232724872856;11863;10987.890121098686;11156.609518666808;11266.277592504484;11506.597269095542;11607.30356178632;11195.552177913118;11410.543578256777;11442.313461192354;11613.941930290295;11853.940730296294;8328.625211865601;8401.453905496122;8516.531590762319;8581.742547723577;8875.112488751074;10888.51001704941;10975.231733778559;11238.55045798159;11301.886981130083;11696.824547631963 05:04:16 INFO - PROCESS | 6771 | |3;mootools.html;1270.2378572856283;1483.2583708145928;1496.50615296952;1654.7269700499419;1796.4969808453639;7573.280538348855;8089.635966381512;8340.29107525861;8346.16538346165;8577.95711021444;8383.287420569259;8465.576721163949;8468.44955077921;8469.195426434495;8480.32157427406;2275.6131457652195;2317.8145748340094;2320.8491448055906;2321.1430855315766;2323.152049501928;2240.7423146338137;2286.78275563822;2291.140822191678;2312.930612081632;2314.1784666443423;2281.954360912781;2287.736910255317;2312.2600767754325;2324.569954558412;2329.8369114162015;2213.50196205854;2220.578090162872;2244.3940136163146;2246.86518808872;2248.55028994201;2239.2050821958132;2260.570491606606;2262.875541845198;2262.9434264143365;2270.9318720438414;8369.288610468118;8542.487450752913;8661.523616201106;8758.56207189638;8758.912410875873;5150.845474635767;5267.130923397634;5296.841094767163;5299.49654782795;5303.787848486056;3386.102682789063;3516.208853008078;3543.291341731638;3634.854605815764;3636.5272514572935;1180.5985964771933;1183.2249876331016;1216.4769149265812;1226.693326668333;2096.916123355064;12049.457774400173;12566.560170394083;12566.623001309976;12586.433610487458;12596.68508287291;4418.9337159942625;4457.710248833815;4464.419625448671;4632.583067523871;4645.744484053342;9620.71137865865;9787.51062446889;9822.901770982342;9825.459599722084;9833.4099954003;5284.9471505284455;5295.073362161684;5295.12630415977;5296.708681022504;5297.54970827484;4304.418903448057;4605.907881842344;4825.5898248649255;4863.9513604864205;4951.851444456672;3679.4112941929698;3737.383331750285;3761.9247615048093;3793.0896584819443;3837.328467518173;1165.2775279326872;1175.6355529785794;1180.8110702287593;1183.3136780667191;1194.940252987347;898.3397203055749;912.5209265135724;956.9234461243084;979.3536266064364;1033.7932413517326;5506.8347949560775;5824.417558244142;5879.853003674857;6073.423024812636;6191.752329906753;894.6868595991481;899.3403844531257;930.2883294279882;956.4356435643564;961.9230461563059;3837.1558257183374;4005.759654420744;4035.616616421435;4085.6935729820384;4172.958270417318;10367.94816025915;10590.682279531626;10662.413567253876;11035.282706624044;11072.612458564072;10986.285891417032;10986.890131098746;10989.175811814146;11008.339499630049;11016.449177541092;7878.842423151505;8330.916690833135;8354.874676879852;8367.623456944451;8369.246767790806;5692.715364231854;5720.74256658443;5806.883862322815;5923.703814809156;5974;9967.750806229902;9981.051800078982;10036.996300369905;10089.344192627455;10112;9323.580438880132;9781.315307928662;9784.9021509784;10092.192624589869;10092.697219083439;6695.598264104169;6881.552699074544;7372.926270737224;7694.345980591713;7882.763517094496;8158.265756081981;8535.189157030072;8551;8555;8559.828803423772;7376.6311684414495;7497.662605182889;7650.65572049248;7768.296145741431;7820.100688420677;7417.480776345604;7554.093508778982;7586.468947173645;7614.390848732199;7615.1242607098675;6939.063226464363;7037.894431583428;7045.506814523139;7047.612381319077;7052.365287124184;5188.610854185876;5229.92155117666;5323.520883120537;5366.7048312343195;5413.215083812904;5167;5210.322658054429;5251.081060814418;5268.9736551317;5389.62272640927 05:04:16 INFO - PROCESS | 6771 | |4;prototype.html;328.82910952501936;333.02257873142327;344.42652982783665;344.44888178913726;344.922392461696;5110.6422550421485;5240.240165176047;5287.947120528794;5338.706371149585;5359.330083739537;5015.62382821289;5122.743862806854;5127.717975511346;5142.845714628567;5180.948190518094;4113.197926404352;4117.649999750025;4136.482939632546;4152.712659075689;4172.2698527757675;4018.5177778666603;4082.9591704083023;4149.8962525936795;4176.498820141572;4192.811323490435;4058.715889887709;4071.491063617048;4078.286299897521;4081.3265811141127;4086.4687590613325;4043.4541336919433;4043.73715708478;4044.4337792709043;4061.715679902408;4083.1833633273463;3634.7092232621326;3642.162302670374;3649.1606930406156;3649.7445178837493;3652.36083685354;4950.2079667253065;5048.116579598593;5076.746162691888;5094.363204599425;5109.284700141983;4675.906481870377;4677.88305292367;4678.836240731592;4681;4694.694844835109;5467.726613669301;5481.4651897468775;5481.917771233435;5503.174523821419;5514.310711161105;3830.5211848518934;3953.8418463261437;3967.147063381387;3982.203559288125;3989.8204580793936;5656.351653183673;5685.40303268155;5687.971560142173;5696.889106624251;5709.200711900337;4015.437838702584;4042;4053.2704113259306;4056.3104272273786;4058.1072164123843;4003.139325045129;4080.8571699990357;4093.529244136903;4100.282450571138;4114.567970363129;4645.117427688729;4647.58171764536;4664.976675116671;4668.206404911173;4693.95306046942;5418.401571536407;5460.645058071213;5496.477834605706;5529.695866727368;5553.250311208016;1262.3561983388538;1270.142653708743;1335.3923964596086;1341.4902337111835;1358.9060806051027;935.6418328086696;936.3773090894479;947.4031360243002;957.167264479907;966.8114717629994;5022.668992716933;5045.217991211368;5073.3911930568565;5087.26234695967;5113.795448182105;5320.467953204648;5350.30446042012;5364.22218778275;5372.623916325898;5375.59683023767;4930.950690493121;5092.185250359925;5105.463926287761;5110.926705391835;5125.026245013435;2836.8723407446714;2859.3423512591803;2869.7847661425476;2872.167071549269;2873.7700983921236;5521.254630624814;5539.889202215933;5569.916451253234;5571.359293681197;5574.554035677136;5288.735563221823;5460.099083651233;5462.754176062087;5487.42382049887;5503.504684578407;5418.726599249252;5460.863478413072;5462.235287059815;5530.225768392428;5544.722763861791;5217.34783152106;5321.414644389191;5346.679199248058;5350.866228344323;5389.487998640123;5265.921011184912;5323.228131920927;5372.811951581676;5395.838124856261;5408.918866216931;5518.978988887069;5532.616845788553;5532.917006244829;5566.832995010156;5571.854835888294;3834.7728726807154;3965.3655415134594;3975.9602403976746;3979.7811120388656;3984.11151914871;5382.165764306539;5499.305340383264;5626.88746225065;5632.113841449387;5668.242844718151;5366.7584958677735;5417.485338892799;5488.204210389551;5496.945030549803;5548.112302031655;5525.972370138124;5534.944650553443;5535.391106978149;5548.278723765885;5559.805406810742;5256.842294731164;5409.350877894678;5434.483724046209;5472.315960504937;5473.863153421196;5566.189074517343;5574.721263936868;5575.135853942646;5577.3028371453565;5583.692896890548;5446.537044351275;5464.879699661639;5469.097598896296;5474.616776825584;5481.232627432083 05:04:16 INFO - PROCESS | 6771 | |5;yui.html;726.9636518174092;743.7991742229598;744.8473063022082;781.632632662649;802.157734378902;14846.925765371172;15620.687586248283;15623.84376156238;15626.765598516004;15638.921805390957;13792.586222413318;13950.372233249504;13954.092983956061;13978.720425591508;13984.300784960762;642.2742301199638;662.4038365471066;747.237817426225;761.4555592751182;763.1872056260092;769.8575763483746;774.577855068986;778.9221077892194;779.0106564662875;779.1195948578098;826.2728798657173;830.0661755525034;830.1366578758084;831.0567505880839;831.4387788242911;691.4226620771661;709.6203531110831;795.5465384730705;820.6471217376526;821.2444551013082;595.9523238140938;596.5376832954452;599.1881001243296;599.7181324777391;599.8800239952027;14191.503297384645;14211.786823197557;14221.502247421395;14222;14229.928850355785;13351.933240333834;13463;13551.186928784304;13552.728945421135;13690.38393272305;12051.93974030133;12199;12403.75192496145;12433.550501618834;12606.432710528048;3817.938154563933;3881.573026967031;3897.9610203897882;3913.6477717005605;3934.6458818706456;65246;65818.67090664612;66880;67432.6628366855;68909;10469.267151299488;10566;10870.565177392973;10980.670579882617;11022.614208502664;17784.555386115193;18692.34576789806;19643.410697679094;19661.606767864563;19769.11039003248;7909.24862138096;8151.959240203761;8186.590670466572;8208.917910820936;8315.95842020786;4507.752073635916;4568.1548913451115;4570.131674981742;4595.6783025187915;4615.446146462379;3455.3434847378917;3486.442169252907;3513.595936467339;3514.2093029068255;3536.3811333017134;634.825423008667;641.2913730327921;647.4723100672936;648.7469886744174;663.151166506872;671.8286836856668;686.3891136888174;702.4520873718508;731.4879584291018;732.1031736123207;9408.388454750419;9419.340646154704;9526.380785248937;9729.173020293212;9878.802423951482;601.5939241012387;615.4983688294026;681.5774219983642;687.9601980128842;730.8903664450374;4376.234159022159;4481.663875209307;4564.2240819060835;4685.906281874343;4930.482299358588;71560.64219678972;88168.55915720381;88239.55880220557;89697.55151224202;90734.09265907388;76758.61620691861;78615.2138478608;79057.20942790614;79690.20309796827;81133;69048.3095169062;70102.29897701059;70941;71736.03575801627;73222.63388683023;9646.083622055894;10061.39631622105;10182.541785619516;10207.438590877573;10296.691099267035;45352;46597.767011166085;46756.53243467522;47278.527214727415;47449;40377.79811100926;40548.1890362197;63260.36739632729;64586;64678.35321646911;11881.287122772661;11942.70143246391;12109.515619375126;12344.938275308925;12938.611841644766;12993.805092923425;13438.260895650443;13498.32508374597;14038.227897465737;14284.928575357057;12574.559890403792;12596.181248218836;12638.557650482557;12748.68128296763;13000.219986800823;12732.681682958;12981.350932453528;13559.136358204261;13966.720665586834;14117.152970821784;13415.195088294733;13488.393022313823;13507.594772156852;13983.580492585239;14158.150510969375;10870;11140.554377825121;11593.786530878971;11601;11610.24533405326;10990.065844403316;11333.26333788301;11441.370724610226;11445.599404021152;11744.94127529357 05:04:16 INFO - PROCESS | 6771 | __end_tp_report 05:04:16 INFO - PROCESS | 6771 | __start_cc_report 05:04:16 INFO - PROCESS | 6771 | _x_x_mozilla_cycle_collect,1161 05:04:16 INFO - PROCESS | 6771 | __end_cc_report 05:04:16 INFO - PROCESS | 6771 | __startTimestamp1479733456975__endTimestamp 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | ------- Summary: start ------- 05:04:16 INFO - PROCESS | 6771 | Number of tests: 6 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#0] dojo.html Cycles:165 Average:5413.99 Median:5615.21 stddev:632.12 (11.3%) stddev-sans-first:605.80 05:04:16 INFO - PROCESS | 6771 | Values: 3031.6 3065.6 3107.4 3122.0 3125.6 5328.4 5349.6 5402.6 5433.1 5435.5 5405.6 5428.1 5500.0 5527.8 5572.1 4921.3 4945.1 4986.8 5019.7 5042.1 4975.9 5037.9 5091.3 5100.5 5123.4 4790.1 5030.3 5032.9 5075.5 5131.6 4806.3 4894.4 4899.4 4900.7 4901.4 4855.4 4867.4 4870.2 4876.6 4880.5 5259.4 5304.9 5322.5 5331.9 5333.7 5685.0 5686.0 5687.9 5691.8 5693.5 5868.8 5877.7 5894.9 5954.7 5975.0 5458.1 5509.3 5515.4 5515.8 5552.9 6046.7 6047.1 6050.7 6051.9 6051.9 5596.7 5609.0 5707.9 5754.1 5787.6 5922.8 5923.7 5924.5 5925.9 5952.3 5881.5 5892.6 5897.6 5904.7 5904.9 5728.7 5760.0 5765.7 5918.3 5956.0 4433.3 4433.6 4434.6 4463.8 4466.9 3938.0 3947.3 3952.4 3973.5 3980.0 5552.1 5564.7 5569.2 5585.2 5608.1 5667.1 5679.0 5906.0 5908.8 5973.0 5535.5 5577.4 5592.7 5612.4 5635.2 4860.7 4906.5 4909.3 4922.1 4949.0 5879.8 5881.9 5943.7 6012.7 6020.6 5833.6 5869.7 5875.6 5929.9 5949.2 6059.5 6062.2 6071.6 6071.8 6074.5 5537.3 5788.6 5791.4 5797.4 5799.3 5649.9 5741.6 5744.6 5771.7 5825.7 5678.5 5682.1 5684.0 5684.3 5687.1 5588.3 5639.3 5652.0 5654.8 5659.0 5524.4 5615.2 5652.6 5657.3 5764.9 5788.5 5805.1 5809.2 5821.4 5825.7 5493.8 5529.4 5533.0 5686.1 5697.5 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#1] ext.html Cycles:180 Average:57395.59 Median:36092.55 stddev:117980.64 (326.9%) stddev-sans-first:118234.42 05:04:16 INFO - PROCESS | 6771 | Values: 555.8 578.9 593.6 615.7 647.4 32988.2 42449.8 43059.0 43102.8 46444.8 44579.3 44587.0 45132.8 45187.3 45226.0 7719.8 8549.1 8794.6 8795.9 8837.9 7761.5 10228.3 10418.1 10480.5 10762.4 10669.3 10721.0 10733.7 10738.7 10744.5 10454.3 10491.8 10500.6 10501.4 10518.3 10435.1 10444.0 10496.2 10500.2 10521.3 40908.2 41094.2 41183.8 41248.4 41335.4 3445.9 3499.5 3554.1 3668.5 3847.5 30835.2 31384.0 31389.8 31424.2 31542.0 4142.8 4258.8 4262.5 4332.8 4402.4 340707.0 341055.0 341150.0 341425.0 341522.0 34168.1 58045.7 58112.0 58227.4 58251.4 35830.3 37014.4 37483.1 37988.4 38035.5 14985.0 15194.7 15202.5 15205.0 15212.7 11341.8 11656.9 12069.8 12498.7 12590.5 8445.2 8579.6 8658.9 8672.6 8735.7 3306.5 3333.5 3339.4 3345.2 3362.7 992.3 1017.3 1042.7 1102.0 1102.7 31219.2 31883.7 32015.5 32239.4 32586.8 1080.5 1088.4 1105.3 1145.6 1174.5 15982.1 16663.8 16850.9 16860.2 16981.8 569574.0 578251.0 578528.0 578767.0 579640.0 39942.8 40028.4 40094.6 40157.2 40211.4 1209.9 1254.5 1290.0 1345.3 1345.4 28422.6 32443.5 32564.3 32751.7 33273.3 48140.3 48708.8 48980.5 49154.0 49168.0 371932.0 373619.0 374822.0 374951.0 375260.0 27627.3 27741.6 28310.3 28575.0 29242.6 43660.6 45792.8 46349.0 46497.1 46575.8 38476.8 39804.6 40194.0 40409.2 41441.6 39463.6 39502.2 40920.2 40951.0 41395.4 39334.4 39877.6 40061.8 40571.7 40597.0 33836.3 35758.6 36354.8 36446.3 36461.6 22861.5 22975.5 23269.0 23405.9 23419.8 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#2] jquery.html Cycles:180 Average:28853.16 Median:2730.40 stddev:81822.99 (2996.7%) stddev-sans-first:82024.58 05:04:16 INFO - PROCESS | 6771 | Values: 374.1 387.9 397.7 402.3 419.2 13163.7 15124.1 16371.6 18744.5 19060.6 18454.4 19004.0 19023.1 19068.0 19232.1 5489.2 5735.8 5736.9 5740.1 5740.3 4588.7 6407.6 6443.4 6443.6 6449.3 6133.4 6351.6 6391.8 6404.5 6408.9 6281.7 6321.9 6322.3 6356.5 6356.7 5421.7 5613.7 5618.2 5649.9 5650.2 22850.4 22930.4 23206.7 23247.8 23642.8 2273.5 2287.1 2367.8 2632.7 2828.1 14368.6 14477.0 14709.6 14714.8 15180.7 1845.5 1926.1 1930.2 1945.0 2009.1 80207.0 80411.6 80480.2 81890.2 83710.6 10440.9 10576.7 10800.7 10909.6 10920.6 14780.6 14839.8 14972.6 14990.6 14997.0 7887.5 7956.0 8015.2 8235.3 8245.1 7525.8 7756.7 7774.8 8037.7 8044.0 6420.8 6436.6 6461.7 6580.5 6644.6 1854.3 1865.8 1870.5 1926.4 1935.6 976.7 999.2 1025.3 1071.7 1117.6 18734.6 19225.0 19957.9 19986.2 19999.8 976.3 1004.7 1023.7 1044.3 1069.5 10145.6 11206.3 11302.6 11335.1 11354.0 486361.0 490085.0 503841.0 504568.0 505427.0 80956.0 81642.0 83702.0 84075.0 84089.0 936.7 961.9 978.3 984.2 992.0 16927.8 17209.6 17798.4 17847.2 17908.8 38657.4 39667.6 39948.0 40297.6 40960.0 51404.5 51726.0 52256.7 52318.2 52475.5 7857.3 8264.5 8286.5 8365.7 8519.0 12237.0 12802.4 12912.0 12978.7 13034.3 11294.3 11436.1 11446.7 11804.2 11863.0 10987.9 11156.6 11266.3 11506.6 11607.3 11195.6 11410.5 11442.3 11613.9 11853.9 8328.6 8401.5 8516.5 8581.7 8875.1 10888.5 10975.2 11238.6 11301.9 11696.8 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#3] mootools.html Cycles:180 Average:5726.08 Median:5240.50 stddev:3237.30 (61.8%) stddev-sans-first:3229.06 05:04:16 INFO - PROCESS | 6771 | Values: 1270.2 1483.3 1496.5 1654.7 1796.5 7573.3 8089.6 8340.3 8346.2 8578.0 8383.3 8465.6 8468.4 8469.2 8480.3 2275.6 2317.8 2320.8 2321.1 2323.2 2240.7 2286.8 2291.1 2312.9 2314.2 2282.0 2287.7 2312.3 2324.6 2329.8 2213.5 2220.6 2244.4 2246.9 2248.6 2239.2 2260.6 2262.9 2262.9 2270.9 8369.3 8542.5 8661.5 8758.6 8758.9 5150.8 5267.1 5296.8 5299.5 5303.8 3386.1 3516.2 3543.3 3634.9 3636.5 1180.6 1183.2 1216.5 1226.7 2096.9 12049.5 12566.6 12566.6 12586.4 12596.7 4418.9 4457.7 4464.4 4632.6 4645.7 9620.7 9787.5 9822.9 9825.5 9833.4 5284.9 5295.1 5295.1 5296.7 5297.5 4304.4 4605.9 4825.6 4864.0 4951.9 3679.4 3737.4 3761.9 3793.1 3837.3 1165.3 1175.6 1180.8 1183.3 1194.9 898.3 912.5 956.9 979.4 1033.8 5506.8 5824.4 5879.9 6073.4 6191.8 894.7 899.3 930.3 956.4 961.9 3837.2 4005.8 4035.6 4085.7 4173.0 10367.9 10590.7 10662.4 11035.3 11072.6 10986.3 10986.9 10989.2 11008.3 11016.4 7878.8 8330.9 8354.9 8367.6 8369.2 5692.7 5720.7 5806.9 5923.7 5974.0 9967.8 9981.1 10037.0 10089.3 10112.0 9323.6 9781.3 9784.9 10092.2 10092.7 6695.6 6881.6 7372.9 7694.3 7882.8 8158.3 8535.2 8551.0 8555.0 8559.8 7376.6 7497.7 7650.7 7768.3 7820.1 7417.5 7554.1 7586.5 7614.4 7615.1 6939.1 7037.9 7045.5 7047.6 7052.4 5188.6 5229.9 5323.5 5366.7 5413.2 5167.0 5210.3 5251.1 5269.0 5389.6 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#4] prototype.html Cycles:180 Average:4560.91 Median:5199.15 stddev:1323.42 (25.5%) stddev-sans-first:1288.44 05:04:16 INFO - PROCESS | 6771 | Values: 328.8 333.0 344.4 344.4 344.9 5110.6 5240.2 5287.9 5338.7 5359.3 5015.6 5122.7 5127.7 5142.8 5180.9 4113.2 4117.6 4136.5 4152.7 4172.3 4018.5 4083.0 4149.9 4176.5 4192.8 4058.7 4071.5 4078.3 4081.3 4086.5 4043.5 4043.7 4044.4 4061.7 4083.2 3634.7 3642.2 3649.2 3649.7 3652.4 4950.2 5048.1 5076.7 5094.4 5109.3 4675.9 4677.9 4678.8 4681.0 4694.7 5467.7 5481.5 5481.9 5503.2 5514.3 3830.5 3953.8 3967.1 3982.2 3989.8 5656.4 5685.4 5688.0 5696.9 5709.2 4015.4 4042.0 4053.3 4056.3 4058.1 4003.1 4080.9 4093.5 4100.3 4114.6 4645.1 4647.6 4665.0 4668.2 4694.0 5418.4 5460.6 5496.5 5529.7 5553.3 1262.4 1270.1 1335.4 1341.5 1358.9 935.6 936.4 947.4 957.2 966.8 5022.7 5045.2 5073.4 5087.3 5113.8 5320.5 5350.3 5364.2 5372.6 5375.6 4931.0 5092.2 5105.5 5110.9 5125.0 2836.9 2859.3 2869.8 2872.2 2873.8 5521.3 5539.9 5569.9 5571.4 5574.6 5288.7 5460.1 5462.8 5487.4 5503.5 5418.7 5460.9 5462.2 5530.2 5544.7 5217.3 5321.4 5346.7 5350.9 5389.5 5265.9 5323.2 5372.8 5395.8 5408.9 5519.0 5532.6 5532.9 5566.8 5571.9 3834.8 3965.4 3976.0 3979.8 3984.1 5382.2 5499.3 5626.9 5632.1 5668.2 5366.8 5417.5 5488.2 5496.9 5548.1 5526.0 5534.9 5535.4 5548.3 5559.8 5256.8 5409.4 5434.5 5472.3 5473.9 5566.2 5574.7 5575.1 5577.3 5583.7 5446.5 5464.9 5469.1 5474.6 5481.2 05:04:16 INFO - PROCESS | 6771 | 05:04:16 INFO - PROCESS | 6771 | [#5] yui.html Cycles:180 Average:17854.07 Median:4566.19 stddev:23579.21 (516.4%) stddev-sans-first:23610.28 05:04:16 INFO - PROCESS | 6771 | Values: 727.0 743.8 744.8 781.6 802.2 14846.9 15620.7 15623.8 15626.8 15638.9 13792.6 13950.4 13954.1 13978.7 13984.3 642.3 662.4 747.2 761.5 763.2 769.9 774.6 778.9 779.0 779.1 826.3 830.1 830.1 831.1 831.4 691.4 709.6 795.5 820.6 821.2 596.0 596.5 599.2 599.7 599.9 14191.5 14211.8 14221.5 14222.0 14229.9 13351.9 13463.0 13551.2 13552.7 13690.4 12051.9 12199.0 12403.8 12433.6 12606.4 3817.9 3881.6 3898.0 3913.6 3934.6 65246.0 65818.7 66880.0 67432.7 68909.0 10469.3 10566.0 10870.6 10980.7 11022.6 17784.6 18692.3 19643.4 19661.6 19769.1 7909.2 8152.0 8186.6 8208.9 8316.0 4507.8 4568.2 4570.1 4595.7 4615.4 3455.3 3486.4 3513.6 3514.2 3536.4 634.8 641.3 647.5 648.7 663.2 671.8 686.4 702.5 731.5 732.1 9408.4 9419.3 9526.4 9729.2 9878.8 601.6 615.5 681.6 688.0 730.9 4376.2 4481.7 4564.2 4685.9 4930.5 71560.6 88168.6 88239.6 89697.6 90734.1 76758.6 78615.2 79057.2 79690.2 81133.0 69048.3 70102.3 70941.0 71736.0 73222.6 9646.1 10061.4 10182.5 10207.4 10296.7 45352.0 46597.8 46756.5 47278.5 47449.0 40377.8 40548.2 63260.4 64586.0 64678.4 11881.3 11942.7 12109.5 12344.9 12938.6 12993.8 13438.3 13498.3 14038.2 14284.9 12574.6 12596.2 12638.6 12748.7 13000.2 12732.7 12981.4 13559.1 13966.7 14117.2 13415.2 13488.4 13507.6 13983.6 14158.2 10870.0 11140.6 11593.8 11601.0 11610.2 10990.1 11333.3 11441.4 11445.6 11744.9 05:04:16 INFO - PROCESS | 6771 | -------- Summary: end -------- 05:04:16 INFO - PROCESS | 6771 | 05:04:17 INFO - TEST-INFO | 6771: exit 0 05:04:17 INFO - TEST-OK | dromaeo_css | took 1118408ms 05:04:17 INFO - TEST-START | kraken 05:04:17 INFO - operating with platform_type : linux_ 05:04:17 INFO - Initialising browser for kraken test... 05:04:17 INFO - TEST-INFO | started process 7071 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcTPfg/profile http://localhost:53481/getInfo.html) 05:04:22 INFO - PROCESS | 7071 | __metrics Screen width/height:1600/1200 05:04:22 INFO - PROCESS | 7071 | colorDepth:24 05:04:22 INFO - PROCESS | 7071 | Browser inner width/height: 1024/697 05:04:22 INFO - PROCESS | 7071 | __metrics 05:04:22 INFO - PROCESS | 7071 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:04:22 INFO - PROCESS | 7071 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:23 INFO - PROCESS | 7071 | console.error: PushService: 05:04:23 INFO - PROCESS | 7071 | stateChangeProcessEnqueue: Error transitioning state 05:04:23 INFO - PROCESS | 7071 | UnknownError 05:04:24 INFO - TEST-INFO | 7071: exit 0 05:04:24 INFO - Browser initialized. 05:04:24 INFO - Running cycle 1/1 for kraken test... 05:04:24 INFO - TEST-INFO | started process 7152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYcTPfg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:36 INFO - PROCESS | 7152 | RSS: Main: 173871104 05:04:36 INFO - PROCESS | 7152 | 05:04:38 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53481/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:39 INFO - PROCESS | 7152 | RSS: Main: 234897408 05:04:39 INFO - PROCESS | 7152 | 05:04:42 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53481/tests/kraken/driver.html?testName=audio-dft) 05:04:43 INFO - PROCESS | 7152 | RSS: Main: 217899008 05:04:43 INFO - PROCESS | 7152 | 05:04:46 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53481/tests/kraken/driver.html?testName=audio-fft) 05:04:46 INFO - PROCESS | 7152 | RSS: Main: 297861120 05:04:46 INFO - PROCESS | 7152 | 05:04:48 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53481/tests/kraken/driver.html?testName=audio-oscillator) 05:04:49 INFO - PROCESS | 7152 | RSS: Main: 210665472 05:04:49 INFO - PROCESS | 7152 | 05:04:51 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53481/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:52 INFO - PROCESS | 7152 | RSS: Main: 213889024 05:04:52 INFO - PROCESS | 7152 | 05:04:55 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53481/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:55 INFO - PROCESS | 7152 | RSS: Main: 253112320 05:04:55 INFO - PROCESS | 7152 | 05:04:59 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53481/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:59 INFO - PROCESS | 7152 | RSS: Main: 252829696 05:04:59 INFO - PROCESS | 7152 | 05:05:02 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53481/tests/kraken/driver.html?testName=json-parse-financial) 05:05:03 INFO - PROCESS | 7152 | RSS: Main: 252231680 05:05:03 INFO - PROCESS | 7152 | 05:05:04 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53481/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:05 INFO - PROCESS | 7152 | RSS: Main: 213803008 05:05:05 INFO - PROCESS | 7152 | 05:05:07 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:07 INFO - PROCESS | 7152 | RSS: Main: 220753920 05:05:07 INFO - PROCESS | 7152 | 05:05:09 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:10 INFO - PROCESS | 7152 | RSS: Main: 230363136 05:05:10 INFO - PROCESS | 7152 | 05:05:12 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:13 INFO - PROCESS | 7152 | RSS: Main: 238854144 05:05:13 INFO - PROCESS | 7152 | 05:05:16 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:17 INFO - PROCESS | 7152 | RSS: Main: 236187648 05:05:17 INFO - PROCESS | 7152 | 05:05:18 INFO - PROCESS | 7152 | Cycle 1(1): loaded http://localhost:53481/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53481/tests/kraken/driver.html?testName=ai-astar) 05:05:19 INFO - PROCESS | 7152 | RSS: Main: 287629312 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | __start_tp_report 05:05:19 INFO - PROCESS | 7152 | _x_x_mozilla_page_load 05:05:19 INFO - PROCESS | 7152 | _x_x_mozilla_page_load_details 05:05:19 INFO - PROCESS | 7152 | |i|pagename|runs| 05:05:19 INFO - PROCESS | 7152 | |0;ai-astar;105;114;114;112;112;112;111;112;112;112 05:05:19 INFO - PROCESS | 7152 | |1;audio-beat-detection;156;125;123;160;129;122;121;123;159;122 05:05:19 INFO - PROCESS | 7152 | |2;audio-dft;163;159;160;161;160;162;162;161;161;161 05:05:19 INFO - PROCESS | 7152 | |3;audio-fft;75;76;75;115;79;76;76;76;104;75 05:05:19 INFO - PROCESS | 7152 | |4;audio-oscillator;83;82;118;82;83;83;101;83;83;113 05:05:19 INFO - PROCESS | 7152 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;118;118 05:05:19 INFO - PROCESS | 7152 | |6;imaging-darkroom;145;147;147;146;146;146;146;147;146;147 05:05:19 INFO - PROCESS | 7152 | |7;imaging-desaturate;95;96;96;97;96;96;96;96;96;96 05:05:19 INFO - PROCESS | 7152 | |8;json-parse-financial;54;52;53;52;52;54;53;53;56;54 05:05:19 INFO - PROCESS | 7152 | |9;json-stringify-tinderbox;63;62;62;63;62;62;62;63;62;63 05:05:19 INFO - PROCESS | 7152 | |10;stanford-crypto-aes;82;81;88;83;80;88;81;81;80;81 05:05:19 INFO - PROCESS | 7152 | |11;stanford-crypto-ccm;143;133;133;145;136;137;154;134;175;137 05:05:19 INFO - PROCESS | 7152 | |12;stanford-crypto-pbkdf2;169;171;164;173;167;167;166;171;176;167 05:05:19 INFO - PROCESS | 7152 | |13;stanford-crypto-sha256-iterative;67;65;65;66;65;67;66;64;64;66 05:05:19 INFO - PROCESS | 7152 | __end_tp_report 05:05:19 INFO - PROCESS | 7152 | __start_cc_report 05:05:19 INFO - PROCESS | 7152 | _x_x_mozilla_cycle_collect,1680 05:05:19 INFO - PROCESS | 7152 | __end_cc_report 05:05:19 INFO - PROCESS | 7152 | __startTimestamp1479733519098__endTimestamp 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | ------- Summary: start ------- 05:05:19 INFO - PROCESS | 7152 | Number of tests: 14 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:1.00 05:05:19 INFO - PROCESS | 7152 | Values: 105.0 114.0 114.0 112.0 112.0 112.0 111.0 112.0 112.0 112.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#1] audio-beat-detection Cycles:10 Average:134.00 Median:127.00 stddev:16.96 (13.4%) stddev-sans-first:16.02 05:05:19 INFO - PROCESS | 7152 | Values: 156.0 125.0 123.0 160.0 129.0 122.0 121.0 123.0 159.0 122.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:0.97 05:05:19 INFO - PROCESS | 7152 | Values: 163.0 159.0 160.0 161.0 160.0 162.0 162.0 161.0 161.0 161.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.41 (19.0%) stddev-sans-first:15.01 05:05:19 INFO - PROCESS | 7152 | Values: 75.0 76.0 75.0 115.0 79.0 76.0 76.0 76.0 104.0 75.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:83.00 stddev:14.12 (17.0%) stddev-sans-first:14.67 05:05:19 INFO - PROCESS | 7152 | Values: 83.0 82.0 118.0 82.0 83.0 83.0 101.0 83.0 83.0 113.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 05:05:19 INFO - PROCESS | 7152 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 118.0 118.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 05:05:19 INFO - PROCESS | 7152 | Values: 145.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 05:05:19 INFO - PROCESS | 7152 | Values: 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.25 (2.3%) stddev-sans-first:1.30 05:05:19 INFO - PROCESS | 7152 | Values: 54.0 52.0 53.0 52.0 52.0 54.0 53.0 53.0 56.0 54.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#9] json-stringify-tinderbox Cycles:10 Average:62.40 Median:62.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:05:19 INFO - PROCESS | 7152 | Values: 63.0 62.0 62.0 63.0 62.0 62.0 62.0 63.0 62.0 63.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.50 stddev:3.03 (3.7%) stddev-sans-first:3.21 05:05:19 INFO - PROCESS | 7152 | Values: 82.0 81.0 88.0 83.0 80.0 88.0 81.0 81.0 80.0 81.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:140.00 stddev:13.12 (9.4%) stddev-sans-first:13.92 05:05:19 INFO - PROCESS | 7152 | Values: 143.0 133.0 133.0 145.0 136.0 137.0 154.0 134.0 175.0 137.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.10 Median:170.00 stddev:3.63 (2.1%) stddev-sans-first:3.86 05:05:19 INFO - PROCESS | 7152 | Values: 169.0 171.0 164.0 173.0 167.0 167.0 166.0 171.0 176.0 167.0 05:05:19 INFO - PROCESS | 7152 | 05:05:19 INFO - PROCESS | 7152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 05:05:19 INFO - PROCESS | 7152 | Values: 67.0 65.0 65.0 66.0 65.0 67.0 66.0 64.0 64.0 66.0 05:05:19 INFO - PROCESS | 7152 | -------- Summary: end -------- 05:05:19 INFO - PROCESS | 7152 | 05:05:20 INFO - TEST-INFO | 7152: exit 0 05:05:20 INFO - TEST-OK | kraken | took 62430ms 05:05:20 INFO - SUITE-END | took 1180s 05:05:20 INFO - Completed test suite (00:19:41) 05:05:20 INFO - javascript benchmark 05:05:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.605891234139, 3065.586145870307, 3107.3940581586585, 3122.0321700272902, 3125.5780469636607, 5328.413874473805, 5349.625526213166, 5402.567794576435, 5433.103537916249, 5435.537979271761, 5405.621606487547, 5428.0500912340285, 5500.0, 5527.751251193696, 5572.080606699889, 4921.311016457699, 4945.109880221558, 4986.825461108862, 5019.723915184682, 5042.117629414856, 4975.850724478253, 5037.924431133536, 5091.287219789232, 5100.464451232623, 5123.385193776733, 4790.065937142259, 5030.2957585938, 5032.899342013139, 5075.467075957026, 5131.615128865331, 4806.327114204014, 4894.388201474816, 4899.436564795059, 4900.730459824708, 4901.362822833044, 4855.393075865517, 4867.440244371872, 4870.245112007645, 4876.585490233334, 4880.463149053601, 5259.368875734898, 5304.920426193572, 5322.547583455411, 5331.920021199685, 5333.653312534673, 5685.0, 5685.971570142165, 5687.914681279784, 5691.8292451226525, 5693.544516438675, 5868.794592189253, 5877.67672777997, 5894.941050589482, 5954.732037058343, 5975.0, 5458.1266997280245, 5509.256250406224, 5515.448455154533, 5515.806946756925, 5552.944470555283, 6046.667433291212, 6047.12316714074, 6050.667213303311, 6051.878962420727, 6051.939480605138, 5596.720163991784, 5609.046462101453, 5707.914381284284, 5754.079347304411, 5787.594868359174, 5922.763089476459, 5923.703814809242, 5924.4667979882015, 5925.911111333334, 5952.255968003999, 5881.529477641779, 5892.587518873637, 5897.587168898136, 5904.7342869570975, 5904.940950590439, 5728.742206600713, 5759.992001399738, 5765.711714414262, 5918.348981612019, 5955.970220148958, 4433.334999749999, 4433.645308375322, 4434.600885920218, 4463.799129039201, 4466.932996005063, 3937.9803100984313, 3947.289487892207, 3952.4268980997595, 3973.523177218752, 3979.9801000994808, 5552.056150454432, 5564.721763911788, 5569.192467092249, 5585.245991791137, 5608.074667679787, 5667.149927510906, 5678.97160514203, 5906.0, 5908.793192238337, 5972.970135149297, 5535.529479994246, 5577.386487486373, 5592.664440133523, 5612.354579223442, 5635.21107045014, 4860.684055536379, 4906.484819094015, 4909.337239472697, 4922.138625740481, 4949.0, 5879.764809407576, 5881.911771323519, 5943.673097979653, 6012.699365031731, 6020.57855950088, 5833.562482813721, 5869.735861886311, 5875.6474611523445, 5929.851753706192, 5949.196858424058, 6059.484943779828, 6062.211912451353, 6071.635701857726, 6071.848203794941, 6074.453299203093, 5537.307836520435, 5788.623739456922, 5791.420857914175, 5797.449242321973, 5799.3040835100055, 5649.943500564942, 5741.569382296428, 5744.626599271034, 5771.68255745938, 5825.679587622722, 5678.517326027334, 5682.062459694104, 5684.0, 5684.317881854038, 5687.090065589486, 5588.273524441796, 5639.2668953035845, 5651.954388438152, 5654.830355089354, 5659.0, 5524.392316845064, 5615.213870058276, 5652.604317697722, 5657.32112146545, 5764.933487304862, 5788.479036886701, 5805.071188609802, 5809.186713860147, 5821.38875418075, 5825.737841797045, 5493.835184944458, 5529.419410961952, 5532.972335138298, 5686.118651609007, 5697.54419646419], "value": 5369.882179122052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7686729853385, 578.8929048126096, 593.5815250248576, 615.7013848283582, 647.4496677823847, 32988.17529561759, 42449.78775106128, 43059.0, 43102.784486077566, 46444.76777616107, 44579.33131003029, 44587.0, 45132.77433612836, 45187.32219016709, 45226.0, 7719.807004824868, 8549.10234425384, 8794.648214071429, 8795.912040879606, 8837.911620883806, 7761.495502792329, 10228.33515821473, 10418.062374386303, 10480.47597620116, 10762.408067556282, 10669.306495077833, 10721.0, 10733.677989660322, 10738.731531711692, 10744.516496757626, 10454.32046916948, 10491.790164196711, 10500.579976800918, 10501.4224217668, 10518.263721539495, 10435.113015393701, 10444.0, 10496.21278404115, 10500.159987201081, 10521.316114452613, 40908.1818363631, 41094.178116437804, 41183.7940810297, 41248.38127428061, 41335.379969300484, 3445.8621655133766, 3499.4750787382095, 3554.0937061049526, 3668.5414323209598, 3847.5190601174854, 30835.229119271975, 31384.0, 31389.843050784828, 31424.214394640087, 31542.0, 4142.792860357, 4258.787060646955, 4262.50981137167, 4332.761698106603, 4402.427684401007, 340707.0, 341055.0, 341149.9999999975, 341425.0, 341522.0, 34168.145796354795, 58045.709771451715, 58112.0, 58227.4177258222, 58251.41748582545, 35830.283394331964, 37014.44478332827, 37483.06292342713, 37988.43017354742, 38035.52769070057, 14985.0, 15194.696106077816, 15202.543923682308, 15205.0, 15212.653216292398, 11341.829872551918, 11656.88343116558, 12069.758604827854, 12498.687532811753, 12590.496380144692, 8445.1977062179, 8579.613917373734, 8658.91341086581, 8672.56637168139, 8735.737927862174, 3306.470964645645, 3333.516640087222, 3339.398908196548, 3345.2305969627123, 3362.6973572378115, 992.3450522655013, 1017.2523195451338, 1042.7393151712072, 1102.0247081333077, 1102.72431892027, 31219.21951951174, 31883.681163188536, 32015.51976720351, 32239.35521289561, 32586.837065814994, 1080.4543705428866, 1088.357868857378, 1105.2926127278547, 1145.6219447582278, 1174.4656181437426, 15982.120983346027, 16663.750043749355, 16850.91574542144, 16860.156992150343, 16981.83018169827, 569574.0, 578251.0, 578528.0, 578767.0, 579640.0, 39942.800285998965, 40028.39957400641, 40094.599054009086, 40157.196856063296, 40211.39682904759, 1209.9334536600395, 1254.5044707340548, 1289.9806502902652, 1345.2668295778824, 1345.4349173347218, 28422.573661394683, 32443.513347300282, 32564.348713025134, 32751.672483274862, 33273.33453330871, 48140.27789583089, 48708.756456217496, 48980.51019489759, 49154.0, 49168.0, 371932.0, 373619.0, 374822.0, 374951.0, 375260.0, 27627.30931726723, 27741.583876241468, 28310.292242694097, 28575.0, 29242.561361579166, 43660.56339436565, 45792.77103614461, 46349.0, 46497.07005859932, 46575.76712116418, 38476.80761596174, 39804.60195398009, 40194.0, 40409.19181616292, 41441.58558414498, 39463.60536394599, 39502.2099558013, 40920.18159636731, 40951.0, 41395.379069314586, 39334.40998384969, 39877.60122398739, 40061.79969100136, 40571.725675663154, 40597.0, 33836.32327353489, 35758.60293272135, 36354.818225908704, 36446.27107457783, 36461.63538364582, 22861.54276914419, 22975.540489190458, 23269.0, 23405.882970585037, 23419.765802341757], "value": 18694.02142690109, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.0648379052369, 387.94568760373534, 397.6520544523541, 402.27791114948667, 419.15362826748185, 13163.6709082273, 15124.092554446726, 16371.590710232234, 18744.536631418043, 19060.61878762424, 18454.354097606585, 19004.0, 19023.143958521865, 19068.04659767013, 19232.13455394507, 5489.204065410513, 5735.827925162252, 5736.942630573682, 5740.138979153139, 5740.282464691913, 4588.678792484528, 6407.615543067408, 6443.420092191702, 6443.613383197, 6449.322821103787, 6133.386661333876, 6351.555391122623, 6391.776287829927, 6404.48764098871, 6408.903866441984, 6281.748730050793, 6321.905171422432, 6322.336154703758, 6356.523260755462, 6356.745730170787, 5421.674699518042, 5613.747381367848, 5618.213450116987, 5649.887002259973, 5650.180723795027, 22850.42873928165, 22930.42673933165, 23206.698387813543, 23247.767522324728, 23642.763572364227, 2273.499830037389, 2287.0737351372723, 2367.763223677636, 2632.670916135483, 2828.123281782654, 14368.64078398038, 14477.0, 14709.55871323862, 14714.779278310834, 15180.696386072217, 1845.5293900055535, 1926.1428664244418, 1930.2279088364626, 1944.980550194494, 2009.0758251204463, 80207.0, 80411.5979420105, 80480.19519804844, 81890.18109818886, 83710.58144709299, 10440.947795260976, 10576.682699519026, 10800.675979720621, 10909.563617455371, 10920.617778377718, 14780.63048423798, 14839.777403338958, 14972.625684357978, 14990.550283491513, 14997.0, 7887.487313324616, 7956.005499312586, 8015.198480152055, 8235.341172706288, 8245.13426090264, 7525.8118547035665, 7756.728514501965, 7774.844503109906, 8037.718679846294, 8043.959780201179, 6420.807375778734, 6436.581622194542, 6461.741530338733, 6580.539362244597, 6644.568103073285, 1854.2768320355071, 1865.7947625761155, 1870.4762666453414, 1926.3931861463593, 1935.6032013437211, 976.702105857706, 999.2006394884064, 1025.2823023883311, 1071.6624263357019, 1117.5864929975799, 18734.625307493774, 19225.0, 19957.900210499145, 19986.20055197776, 19999.800002000084, 976.3165783951263, 1004.7488127968008, 1023.6621914768109, 1044.3368461027303, 1069.5187165775433, 10145.64490242838, 11206.327620342805, 11302.604408845651, 11335.093192544577, 11354.0, 486361.0, 490085.0, 503841.0, 504568.0, 505427.0, 80956.0, 81642.0, 83702.0, 84075.0, 84089.0, 936.6768464879469, 961.9374740641836, 978.3298440568234, 984.2224642532462, 991.9851202231972, 16927.830721692626, 17209.56976075558, 17798.377056803467, 17847.196876140344, 17908.820911790714, 38657.42013869851, 39667.60332396639, 39948.0, 40297.59702402938, 40960.0, 51404.48595513997, 51726.0, 52256.73871630617, 52318.215226770866, 52475.47524524706, 7857.253560911704, 8264.545450000307, 8286.46138001028, 8365.707200247962, 8519.0, 12237.042073268234, 12802.423890925116, 12912.0, 12978.675533111747, 13034.283114428417, 11294.322340659586, 11436.142289328167, 11446.713832154262, 11804.232724872856, 11863.0, 10987.890121098686, 11156.609518666808, 11266.277592504484, 11506.597269095542, 11607.30356178632, 11195.552177913118, 11410.543578256777, 11442.313461192354, 11613.941930290295, 11853.940730296294, 8328.625211865601, 8401.453905496122, 8516.531590762319, 8581.742547723577, 8875.112488751074, 10888.51001704941, 10975.231733778559, 11238.55045798159, 11301.886981130083, 11696.824547631963], "value": 9326.757416373686, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1270.2378572856283, 1483.2583708145928, 1496.50615296952, 1654.7269700499419, 1796.4969808453639, 7573.280538348855, 8089.635966381512, 8340.29107525861, 8346.16538346165, 8577.95711021444, 8383.287420569259, 8465.576721163949, 8468.44955077921, 8469.195426434495, 8480.32157427406, 2275.6131457652195, 2317.8145748340094, 2320.8491448055906, 2321.1430855315766, 2323.152049501928, 2240.7423146338137, 2286.78275563822, 2291.140822191678, 2312.930612081632, 2314.1784666443423, 2281.954360912781, 2287.736910255317, 2312.2600767754325, 2324.569954558412, 2329.8369114162015, 2213.50196205854, 2220.578090162872, 2244.3940136163146, 2246.86518808872, 2248.55028994201, 2239.2050821958132, 2260.570491606606, 2262.875541845198, 2262.9434264143365, 2270.9318720438414, 8369.288610468118, 8542.487450752913, 8661.523616201106, 8758.56207189638, 8758.912410875873, 5150.845474635767, 5267.130923397634, 5296.841094767163, 5299.49654782795, 5303.787848486056, 3386.102682789063, 3516.208853008078, 3543.291341731638, 3634.854605815764, 3636.5272514572935, 1180.5985964771933, 1183.2249876331016, 1216.4769149265812, 1226.693326668333, 2096.916123355064, 12049.457774400173, 12566.560170394083, 12566.623001309976, 12586.433610487458, 12596.68508287291, 4418.9337159942625, 4457.710248833815, 4464.419625448671, 4632.583067523871, 4645.744484053342, 9620.71137865865, 9787.51062446889, 9822.901770982342, 9825.459599722084, 9833.4099954003, 5284.9471505284455, 5295.073362161684, 5295.12630415977, 5296.708681022504, 5297.54970827484, 4304.418903448057, 4605.907881842344, 4825.5898248649255, 4863.9513604864205, 4951.851444456672, 3679.4112941929698, 3737.383331750285, 3761.9247615048093, 3793.0896584819443, 3837.328467518173, 1165.2775279326872, 1175.6355529785794, 1180.8110702287593, 1183.3136780667191, 1194.940252987347, 898.3397203055749, 912.5209265135724, 956.9234461243084, 979.3536266064364, 1033.7932413517326, 5506.8347949560775, 5824.417558244142, 5879.853003674857, 6073.423024812636, 6191.752329906753, 894.6868595991481, 899.3403844531257, 930.2883294279882, 956.4356435643564, 961.9230461563059, 3837.1558257183374, 4005.759654420744, 4035.616616421435, 4085.6935729820384, 4172.958270417318, 10367.94816025915, 10590.682279531626, 10662.413567253876, 11035.282706624044, 11072.612458564072, 10986.285891417032, 10986.890131098746, 10989.175811814146, 11008.339499630049, 11016.449177541092, 7878.842423151505, 8330.916690833135, 8354.874676879852, 8367.623456944451, 8369.246767790806, 5692.715364231854, 5720.74256658443, 5806.883862322815, 5923.703814809156, 5974.0, 9967.750806229902, 9981.051800078982, 10036.996300369905, 10089.344192627455, 10112.0, 9323.580438880132, 9781.315307928662, 9784.9021509784, 10092.192624589869, 10092.697219083439, 6695.598264104169, 6881.552699074544, 7372.926270737224, 7694.345980591713, 7882.763517094496, 8158.265756081981, 8535.189157030072, 8551.0, 8555.0, 8559.828803423772, 7376.6311684414495, 7497.662605182889, 7650.65572049248, 7768.296145741431, 7820.100688420677, 7417.480776345604, 7554.093508778982, 7586.468947173645, 7614.390848732199, 7615.1242607098675, 6939.063226464363, 7037.894431583428, 7045.506814523139, 7047.612381319077, 7052.365287124184, 5188.610854185876, 5229.92155117666, 5323.520883120537, 5366.7048312343195, 5413.215083812904, 5167.0, 5210.322658054429, 5251.081060814418, 5268.9736551317, 5389.62272640927], "value": 4602.298546825322, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.82910952501936, 333.02257873142327, 344.42652982783665, 344.44888178913726, 344.922392461696, 5110.6422550421485, 5240.240165176047, 5287.947120528794, 5338.706371149585, 5359.330083739537, 5015.62382821289, 5122.743862806854, 5127.717975511346, 5142.845714628567, 5180.948190518094, 4113.197926404352, 4117.649999750025, 4136.482939632546, 4152.712659075689, 4172.2698527757675, 4018.5177778666603, 4082.9591704083023, 4149.8962525936795, 4176.498820141572, 4192.811323490435, 4058.715889887709, 4071.491063617048, 4078.286299897521, 4081.3265811141127, 4086.4687590613325, 4043.4541336919433, 4043.73715708478, 4044.4337792709043, 4061.715679902408, 4083.1833633273463, 3634.7092232621326, 3642.162302670374, 3649.1606930406156, 3649.7445178837493, 3652.36083685354, 4950.2079667253065, 5048.116579598593, 5076.746162691888, 5094.363204599425, 5109.284700141983, 4675.906481870377, 4677.88305292367, 4678.836240731592, 4681.0, 4694.694844835109, 5467.726613669301, 5481.4651897468775, 5481.917771233435, 5503.174523821419, 5514.310711161105, 3830.5211848518934, 3953.8418463261437, 3967.147063381387, 3982.203559288125, 3989.8204580793936, 5656.351653183673, 5685.40303268155, 5687.971560142173, 5696.889106624251, 5709.200711900337, 4015.437838702584, 4042.0, 4053.2704113259306, 4056.3104272273786, 4058.1072164123843, 4003.139325045129, 4080.8571699990357, 4093.529244136903, 4100.282450571138, 4114.567970363129, 4645.117427688729, 4647.58171764536, 4664.976675116671, 4668.206404911173, 4693.95306046942, 5418.401571536407, 5460.645058071213, 5496.477834605706, 5529.695866727368, 5553.250311208016, 1262.3561983388538, 1270.142653708743, 1335.3923964596086, 1341.4902337111835, 1358.9060806051027, 935.6418328086696, 936.3773090894479, 947.4031360243002, 957.167264479907, 966.8114717629994, 5022.668992716933, 5045.217991211368, 5073.3911930568565, 5087.26234695967, 5113.795448182105, 5320.467953204648, 5350.30446042012, 5364.22218778275, 5372.623916325898, 5375.59683023767, 4930.950690493121, 5092.185250359925, 5105.463926287761, 5110.926705391835, 5125.026245013435, 2836.8723407446714, 2859.3423512591803, 2869.7847661425476, 2872.167071549269, 2873.7700983921236, 5521.254630624814, 5539.889202215933, 5569.916451253234, 5571.359293681197, 5574.554035677136, 5288.735563221823, 5460.099083651233, 5462.754176062087, 5487.42382049887, 5503.504684578407, 5418.726599249252, 5460.863478413072, 5462.235287059815, 5530.225768392428, 5544.722763861791, 5217.34783152106, 5321.414644389191, 5346.679199248058, 5350.866228344323, 5389.487998640123, 5265.921011184912, 5323.228131920927, 5372.811951581676, 5395.838124856261, 5408.918866216931, 5518.978988887069, 5532.616845788553, 5532.917006244829, 5566.832995010156, 5571.854835888294, 3834.7728726807154, 3965.3655415134594, 3975.9602403976746, 3979.7811120388656, 3984.11151914871, 5382.165764306539, 5499.305340383264, 5626.88746225065, 5632.113841449387, 5668.242844718151, 5366.7584958677735, 5417.485338892799, 5488.204210389551, 5496.945030549803, 5548.112302031655, 5525.972370138124, 5534.944650553443, 5535.391106978149, 5548.278723765885, 5559.805406810742, 5256.842294731164, 5409.350877894678, 5434.483724046209, 5472.315960504937, 5473.863153421196, 5566.189074517343, 5574.721263936868, 5575.135853942646, 5577.3028371453565, 5583.692896890548, 5446.537044351275, 5464.879699661639, 5469.097598896296, 5474.616776825584, 5481.232627432083], "value": 4140.639119103913, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.9636518174092, 743.7991742229598, 744.8473063022082, 781.632632662649, 802.157734378902, 14846.925765371172, 15620.687586248283, 15623.84376156238, 15626.765598516004, 15638.921805390957, 13792.586222413318, 13950.372233249504, 13954.092983956061, 13978.720425591508, 13984.300784960762, 642.2742301199638, 662.4038365471066, 747.237817426225, 761.4555592751182, 763.1872056260092, 769.8575763483746, 774.577855068986, 778.9221077892194, 779.0106564662875, 779.1195948578098, 826.2728798657173, 830.0661755525034, 830.1366578758084, 831.0567505880839, 831.4387788242911, 691.4226620771661, 709.6203531110831, 795.5465384730705, 820.6471217376526, 821.2444551013082, 595.9523238140938, 596.5376832954452, 599.1881001243296, 599.7181324777391, 599.8800239952027, 14191.503297384645, 14211.786823197557, 14221.502247421395, 14222.0, 14229.928850355785, 13351.933240333834, 13463.0, 13551.186928784304, 13552.728945421135, 13690.38393272305, 12051.93974030133, 12199.0, 12403.75192496145, 12433.550501618834, 12606.432710528048, 3817.938154563933, 3881.573026967031, 3897.9610203897882, 3913.6477717005605, 3934.6458818706456, 65246.0, 65818.67090664612, 66880.0, 67432.6628366855, 68909.0, 10469.267151299488, 10566.0, 10870.565177392973, 10980.670579882617, 11022.614208502664, 17784.555386115193, 18692.34576789806, 19643.410697679094, 19661.606767864563, 19769.11039003248, 7909.24862138096, 8151.959240203761, 8186.590670466572, 8208.917910820936, 8315.95842020786, 4507.752073635916, 4568.1548913451115, 4570.131674981742, 4595.6783025187915, 4615.446146462379, 3455.3434847378917, 3486.442169252907, 3513.595936467339, 3514.2093029068255, 3536.3811333017134, 634.825423008667, 641.2913730327921, 647.4723100672936, 648.7469886744174, 663.151166506872, 671.8286836856668, 686.3891136888174, 702.4520873718508, 731.4879584291018, 732.1031736123207, 9408.388454750419, 9419.340646154704, 9526.380785248937, 9729.173020293212, 9878.802423951482, 601.5939241012387, 615.4983688294026, 681.5774219983642, 687.9601980128842, 730.8903664450374, 4376.234159022159, 4481.663875209307, 4564.2240819060835, 4685.906281874343, 4930.482299358588, 71560.64219678972, 88168.55915720381, 88239.55880220557, 89697.55151224202, 90734.09265907388, 76758.61620691861, 78615.2138478608, 79057.20942790614, 79690.20309796827, 81133.0, 69048.3095169062, 70102.29897701059, 70941.0, 71736.03575801627, 73222.63388683023, 9646.083622055894, 10061.39631622105, 10182.541785619516, 10207.438590877573, 10296.691099267035, 45352.0, 46597.767011166085, 46756.53243467522, 47278.527214727415, 47449.0, 40377.79811100926, 40548.1890362197, 63260.36739632729, 64586.0, 64678.35321646911, 11881.287122772661, 11942.70143246391, 12109.515619375126, 12344.938275308925, 12938.611841644766, 12993.805092923425, 13438.260895650443, 13498.32508374597, 14038.227897465737, 14284.928575357057, 12574.559890403792, 12596.181248218836, 12638.557650482557, 12748.68128296763, 13000.219986800823, 12732.681682958, 12981.350932453528, 13559.136358204261, 13966.720665586834, 14117.152970821784, 13415.195088294733, 13488.393022313823, 13507.594772156852, 13983.580492585239, 14158.150510969375, 10870.0, 11140.554377825121, 11593.786530878971, 11601.0, 11610.24533405326, 10990.065844403316, 11333.26333788301, 11441.370724610226, 11445.599404021152, 11744.94127529357], "value": 7119.715824806416, "unit": "score"}], "name": "dromaeo_css", "value": 7090.187698389756, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 114.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 123.0, 160.0, 129.0, 122.0, 121.0, 123.0, 159.0, 122.0], "value": 134.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 159.0, 160.0, 161.0, 160.0, 162.0, 162.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 115.0, 79.0, 76.0, 76.0, 76.0, 104.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 118.0, 82.0, 83.0, 83.0, 101.0, 83.0, 83.0, 113.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 53.0, 52.0, 52.0, 54.0, 53.0, 53.0, 56.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 88.0, 83.0, 80.0, 88.0, 81.0, 81.0, 80.0, 81.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 133.0, 145.0, 136.0, 137.0, 154.0, 134.0, 175.0, 137.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 164.0, 173.0, 167.0, 167.0, 166.0, 171.0, 176.0, 167.0], "value": 169.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 65.0, 67.0, 66.0, 64.0, 64.0, 66.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1515.0, "alertThreshold": 2.0}]} 05:05:20 INFO - Return code: 0 05:05:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:20 INFO - # TBPL SUCCESS # 05:05:20 INFO - Running post-action listener: _resource_record_post_action 05:05:20 INFO - [mozharness: 2016-11-21 13:05:20.922719Z] Finished run-tests step (success) 05:05:20 INFO - Running post-run listener: _resource_record_post_run 05:05:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390307840; Read time: 20; Write time: 257120 05:05:20 INFO - TinderboxPrint: CPU usage
13.1% 05:05:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:05:20 INFO - TinderboxPrint: I/O write bytes / time
390,307,840 / 257,120 05:05:20 INFO - TinderboxPrint: CPU idle
8,302.7 (86.9%) 05:05:20 INFO - TinderboxPrint: CPU user
1,205.1 (12.6%) 05:05:20 INFO - TinderboxPrint: Swap in / out
0 / 0 05:05:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102858752; Read time: 0; Write time: 62476 05:05:21 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287449088; Read time: 0; Write time: 194644 05:05:21 INFO - Running post-run listener: _upload_blobber_files 05:05:21 INFO - Blob upload gear active. 05:05:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:21 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 05:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:05:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:23 INFO - (blobuploader) - INFO - Done attempting. 05:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:26 INFO - (blobuploader) - INFO - Done attempting. 05:05:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:27 INFO - (blobuploader) - INFO - Done attempting. 05:05:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:27 INFO - Return code: 0 05:05:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/099d308192ad201b1c73a892d58ecfce677ae598f79ebb1e96435fab34643046982df3e1ad158c4143887feacd28889a78607f79d1c5ac025711c4d50ff4bd0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab0c4eac522ac3236fcc48d685e60d6e203012615576f50b984417f52a244d91d62f98a528bf35421f708ac7b93cea9a6f77c8b45d9405b25651f3c1991b33dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d60fdc9b795522e6445deced41c8d1413b72d8ca68bd34667cecc9d738866298122a1040f81cef65e9d23b6f226b00de4160cf29359d645206db035d993db55e"} 05:05:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:27 INFO - Contents: 05:05:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/099d308192ad201b1c73a892d58ecfce677ae598f79ebb1e96435fab34643046982df3e1ad158c4143887feacd28889a78607f79d1c5ac025711c4d50ff4bd0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab0c4eac522ac3236fcc48d685e60d6e203012615576f50b984417f52a244d91d62f98a528bf35421f708ac7b93cea9a6f77c8b45d9405b25651f3c1991b33dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d60fdc9b795522e6445deced41c8d1413b72d8ca68bd34667cecc9d738866298122a1040f81cef65e9d23b6f226b00de4160cf29359d645206db035d993db55e"} 05:05:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:27 INFO - Copying logs to upload dir... 05:05:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.955676 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-11-21 05:05:26.542448) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 05:05:26.545775) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/099d308192ad201b1c73a892d58ecfce677ae598f79ebb1e96435fab34643046982df3e1ad158c4143887feacd28889a78607f79d1c5ac025711c4d50ff4bd0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab0c4eac522ac3236fcc48d685e60d6e203012615576f50b984417f52a244d91d62f98a528bf35421f708ac7b93cea9a6f77c8b45d9405b25651f3c1991b33dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d60fdc9b795522e6445deced41c8d1413b72d8ca68bd34667cecc9d738866298122a1040f81cef65e9d23b6f226b00de4160cf29359d645206db035d993db55e"} build_url:https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011762 build_url: 'https://queue.taskcluster.net/v1/task/WzBNY_BPR4K30NdryPOHwQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/099d308192ad201b1c73a892d58ecfce677ae598f79ebb1e96435fab34643046982df3e1ad158c4143887feacd28889a78607f79d1c5ac025711c4d50ff4bd0c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ab0c4eac522ac3236fcc48d685e60d6e203012615576f50b984417f52a244d91d62f98a528bf35421f708ac7b93cea9a6f77c8b45d9405b25651f3c1991b33dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d60fdc9b795522e6445deced41c8d1413b72d8ca68bd34667cecc9d738866298122a1040f81cef65e9d23b6f226b00de4160cf29359d645206db035d993db55e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 05:05:26.571563) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:05:26.571926) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479728910.828004-1964127997 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 05:05:26.657742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 05:05:26.658140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 05:05:26.658534) ========= ========= Total master_lag: 0.18 =========