builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1477069199.05 results: success (0) buildid: 20161021095946 builduid: 6bc55d91008d4738ba4e5c2294cb1cbe revision: 806054dd12bdcbdee81dbd75f1583156cef9b649 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.049040) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.049477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.049762) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.075356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.075785) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-21 09:59:59-- 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% 26.1M=0s 2016-10-21 09:59:59 (26.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127520 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.218177) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.218488) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019232 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 09:59:59.270350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 09:59:59.270749) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 806054dd12bdcbdee81dbd75f1583156cef9b649 --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 806054dd12bdcbdee81dbd75f1583156cef9b649 --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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-21 09:59:59,870 truncating revision to first 12 chars 2016-10-21 09:59:59,870 Setting DEBUG logging. 2016-10-21 09:59:59,870 attempt 1/10 2016-10-21 09:59:59,870 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/806054dd12bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-21 10:00:01,265 unpacking tar archive at: mozilla-inbound-806054dd12bd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.729479 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-21 10:00:01.014233) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 10:00:01.014541) ========= script_repo_revision: 806054dd12bdcbdee81dbd75f1583156cef9b649 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-21 10:00:01.014936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 10:00:01.015229) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-21 10:00:01.025597) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-21 10:00:01.026022) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:01 INFO - MultiFileLogger online at 20161021 10:00:01 in /builds/slave/test 10:00:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:00:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:01 INFO - {'append_to_log': False, 10:00:01 INFO - 'base_work_dir': '/builds/slave/test', 10:00:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:00:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:01 INFO - 'branch': 'Mozilla-Inbound', 10:00:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:01 INFO - 'config_files': ('talos/linux_config.py',), 10:00:01 INFO - 'default_actions': ('clobber', 10:00:01 INFO - 'read-buildbot-config', 10:00:01 INFO - 'download-and-extract', 10:00:01 INFO - 'populate-webroot', 10:00:01 INFO - 'create-virtualenv', 10:00:01 INFO - 'install', 10:00:01 INFO - 'run-tests'), 10:00:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:01 INFO - 'download_minidump_stackwalk': True, 10:00:01 INFO - 'download_symbols': 'ondemand', 10:00:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:01 INFO - 'installer_path': 'installer.exe', 10:00:01 INFO - 'log_level': 'info', 10:00:01 INFO - 'log_name': 'talos', 10:00:01 INFO - 'log_to_console': True, 10:00:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:01 INFO - 'opt_config_files': (), 10:00:01 INFO - 'pip_index': False, 10:00:01 INFO - 'sps_profile': False, 10:00:01 INFO - 'sps_profile_interval': 0, 10:00:01 INFO - 'suite': 'dromaeojs-e10s', 10:00:01 INFO - 'system_bits': '32', 10:00:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:01 INFO - 'title': 'talos-linux64-ix-051', 10:00:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:01 INFO - 'use_talos_json': True, 10:00:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:01 INFO - 'work_dir': 'build'} 10:00:01 INFO - [mozharness: 2016-10-21 17:00:01.728643Z] Running clobber step. 10:00:01 INFO - Running pre-action listener: _resource_record_pre_action 10:00:01 INFO - Running main action method: clobber 10:00:01 INFO - rmtree: /builds/slave/test/build 10:00:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:01 INFO - Running post-action listener: _resource_record_post_action 10:00:01 INFO - [mozharness: 2016-10-21 17:00:01.732952Z] Finished clobber step (success) 10:00:01 INFO - [mozharness: 2016-10-21 17:00:01.733048Z] Running read-buildbot-config step. 10:00:01 INFO - Running pre-action listener: _resource_record_pre_action 10:00:01 INFO - Running main action method: read_buildbot_config 10:00:01 INFO - Using buildbot properties: 10:00:01 INFO - { 10:00:01 INFO - "project": "", 10:00:01 INFO - "product": "firefox", 10:00:01 INFO - "script_repo_revision": "production", 10:00:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 10:00:01 INFO - "repository": "", 10:00:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 10:00:01 INFO - "buildid": "20161021095946", 10:00:01 INFO - "stage_platform": "linux64-pgo", 10:00:01 INFO - "basedir": "/builds/slave/test", 10:00:01 INFO - "buildnumber": 1340, 10:00:01 INFO - "platform": "ubuntu64_hw", 10:00:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:00:01 INFO - "slavebuilddir": "test", 10:00:01 INFO - "branch": "mozilla-inbound", 10:00:01 INFO - "revision": "806054dd12bdcbdee81dbd75f1583156cef9b649", 10:00:01 INFO - "slavename": "talos-linux64-ix-051", 10:00:01 INFO - "builduid": "6bc55d91008d4738ba4e5c2294cb1cbe", 10:00:01 INFO - "repo_path": "integration/mozilla-inbound" 10:00:01 INFO - } 10:00:01 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:00:01 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 10:00:01 INFO - Running post-action listener: _resource_record_post_action 10:00:01 INFO - [mozharness: 2016-10-21 17:00:01.735430Z] Finished read-buildbot-config step (success) 10:00:01 INFO - [mozharness: 2016-10-21 17:00:01.735518Z] Running download-and-extract step. 10:00:01 INFO - Running pre-action listener: _resource_record_pre_action 10:00:01 INFO - Running main action method: download_and_extract 10:00:01 INFO - mkdir: /builds/slave/test/build/tests 10:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:00:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:00:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:00:01 INFO - Downloaded 1361 bytes. 10:00:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:00:01 INFO - Using the following test package requirements: 10:00:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:00:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:00:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'jsshell-linux-x86_64.zip'], 10:00:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:00:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:00:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:00:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:00:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:00:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:00:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:00:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:00:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:00:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:00:01 INFO - Http code: 200 10:00:01 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 10:00:01 INFO - x-amz-cf-id: A4c3qjmfeQ0XIFH_yTLehLgmRoYkOLtOWkhVEPAi8wQl6pmVxhKeow== 10:00:01 INFO - x-amz-replication-status: COMPLETED 10:00:01 INFO - x-amz-version-id: OM5yD4dRJ8RhyAL2EsqnvnA0dkJ_flHF 10:00:02 INFO - Expected file size: 22032363 10:00:02 INFO - Obtained file size: 22032363 10:00:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:00:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:00:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:00:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:00:06 INFO - Http code: 200 10:00:06 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:00:06 INFO - x-amz-cf-id: J3s7dGMd6vaCkxxHyzCr4ejkEVuEpTZrWM1U-gABqd6nhjLrjhzJtg== 10:00:06 INFO - x-amz-replication-status: COMPLETED 10:00:06 INFO - x-amz-version-id: OM5yD4dRJ8RhyAL2EsqnvnA0dkJ_flHF 10:00:06 INFO - Expected file size: 22032363 10:00:06 INFO - Obtained file size: 22032363 10:00:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:00:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:00:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:00:11 INFO - Http code: 200 10:00:11 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 10:00:11 INFO - x-amz-cf-id: R1t0eugM_UF4jwNxBQlUopuo15ANlpsHOJWb15ixtcywd40wsrLHSw== 10:00:11 INFO - x-amz-replication-status: COMPLETED 10:00:11 INFO - x-amz-version-id: .D7TaBJZIpbgC1UZQTgjog3Yvf_CrXc7 10:00:11 INFO - Expected file size: 14409028 10:00:11 INFO - Obtained file size: 14409028 10:00:11 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')]} 10:00:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:00:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:00:12 INFO - Downloaded 59342256 bytes. 10:00:12 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:00:12 INFO - mkdir: /builds/slave/test/properties 10:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:12 INFO - Contents: 10:00:12 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:00:12 INFO - Running post-action listener: _resource_record_post_action 10:00:12 INFO - Running post-action listener: set_extra_try_arguments 10:00:12 INFO - [mozharness: 2016-10-21 17:00:12.477415Z] Finished download-and-extract step (success) 10:00:12 INFO - [mozharness: 2016-10-21 17:00:12.477648Z] Running populate-webroot step. 10:00:12 INFO - Running pre-action listener: _resource_record_pre_action 10:00:12 INFO - Running main action method: populate_webroot 10:00:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:12 INFO - '--tppagecycles', 10:00:12 INFO - '7'], 10:00:12 INFO - 'tests': ['tsvgm']}}, 10:00:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:00:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['damp', 'tps']}, 10:00:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'tests': ['damp', 'tps']}, 10:00:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['dromaeo_dom']}, 10:00:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['basic_compositor_video']}, 10:00:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:00:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['a11yr', 10:00:12 INFO - 'ts_paint', 10:00:12 INFO - 'tpaint', 10:00:12 INFO - 'sessionrestore', 10:00:12 INFO - 'sessionrestore_no_auto_restore', 10:00:12 INFO - 'tabpaint']}, 10:00:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['tsvgx', 10:00:12 INFO - 'tsvgr_opacity', 10:00:12 INFO - 'tart', 10:00:12 INFO - 'tscrollx', 10:00:12 INFO - 'cart']}, 10:00:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:12 INFO - 'tsvgr_opacity', 10:00:12 INFO - 'tart', 10:00:12 INFO - 'tscrollx', 10:00:12 INFO - 'cart']}, 10:00:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'talos_options': ['--disable-e10s'], 10:00:12 INFO - 'tests': ['tp5o']}, 10:00:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'tests': ['tp5o']}, 10:00:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'talos_options': ['--disable-e10s', 10:00:12 INFO - '--xperf_path', 10:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:12 INFO - 'tests': ['tp5n']}, 10:00:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:00:12 INFO - 'talos_options': ['--xperf_path', 10:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:12 INFO - 'tests': ['tp5n']}}, 10:00:12 INFO - 'talos.zip': {'path': '', 10:00:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:12 INFO - Running post-action listener: _resource_record_post_action 10:00:12 INFO - [mozharness: 2016-10-21 17:00:12.493446Z] Finished populate-webroot step (success) 10:00:12 INFO - [mozharness: 2016-10-21 17:00:12.493535Z] Running create-virtualenv step. 10:00:12 INFO - Running pre-action listener: _resource_record_pre_action 10:00:12 INFO - Running main action method: create_virtualenv 10:00:12 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:12 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 10:00:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:12 INFO - Using real prefix '/usr' 10:00:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:13 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:15 INFO - Installing pip.................done. 10:00:15 INFO - Return code: 0 10:00:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:00:15 INFO - Reading from file tmpfile_stdout 10:00:15 INFO - Output received: 10:00:15 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) 10:00:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:15 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')]} 10:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:15 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')]} 10:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:15 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:15 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 10:00:15 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 10:00:15 INFO - Using env: {'DISPLAY': ':0', 10:00:15 INFO - 'HOME': '/home/cltbld', 10:00:15 INFO - 'LANG': 'en_US.UTF-8', 10:00:15 INFO - 'LANGUAGE': 'en_US:en', 10:00:15 INFO - 'LOGNAME': 'cltbld', 10:00:15 INFO - 'MAIL': '/var/mail/cltbld', 10:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:15 INFO - 'MOZ_NO_REMOTE': '1', 10:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:15 INFO - 'NO_EM_RESTART': '1', 10:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:15 INFO - 'PWD': '/builds/slave/test', 10:00:15 INFO - 'SHELL': '/bin/bash', 10:00:15 INFO - 'SHLVL': '1', 10:00:15 INFO - 'TERM': 'linux', 10:00:15 INFO - 'TMOUT': '86400', 10:00:15 INFO - 'USER': 'cltbld', 10:00:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:15 INFO - '_': '/tools/buildbot/bin/python'} 10:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:15 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 10:00:15 INFO - Cleaning up... 10:00:15 INFO - Return code: 0 10:00:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00:15 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')]} 10:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:15 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')]} 10:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:15 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:15 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 10:00:15 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 10:00:15 INFO - Using env: {'DISPLAY': ':0', 10:00:15 INFO - 'HOME': '/home/cltbld', 10:00:15 INFO - 'LANG': 'en_US.UTF-8', 10:00:15 INFO - 'LANGUAGE': 'en_US:en', 10:00:15 INFO - 'LOGNAME': 'cltbld', 10:00:15 INFO - 'MAIL': '/var/mail/cltbld', 10:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:15 INFO - 'MOZ_NO_REMOTE': '1', 10:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:15 INFO - 'NO_EM_RESTART': '1', 10:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:15 INFO - 'PWD': '/builds/slave/test', 10:00:15 INFO - 'SHELL': '/bin/bash', 10:00:15 INFO - 'SHLVL': '1', 10:00:15 INFO - 'TERM': 'linux', 10:00:15 INFO - 'TMOUT': '86400', 10:00:15 INFO - 'USER': 'cltbld', 10:00:15 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:15 INFO - '_': '/tools/buildbot/bin/python'} 10:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:15 INFO - Downloading/unpacking psutil>=3.1.1 10:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:17 INFO - Installing collected packages: psutil 10:00:17 INFO - Running setup.py install for psutil 10:00:17 INFO - building 'psutil._psutil_linux' extension 10:00:17 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 10:00:18 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 10:00:18 INFO - building 'psutil._psutil_posix' extension 10:00:18 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 10:00:18 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 10:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:18 INFO - Successfully installed psutil 10:00:18 INFO - Cleaning up... 10:00:18 INFO - Return code: 0 10:00:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:00:18 INFO - Using env: {'DISPLAY': ':0', 10:00:18 INFO - 'HOME': '/home/cltbld', 10:00:18 INFO - 'LANG': 'en_US.UTF-8', 10:00:18 INFO - 'LANGUAGE': 'en_US:en', 10:00:18 INFO - 'LOGNAME': 'cltbld', 10:00:18 INFO - 'MAIL': '/var/mail/cltbld', 10:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:18 INFO - 'MOZ_NO_REMOTE': '1', 10:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:18 INFO - 'NO_EM_RESTART': '1', 10:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:18 INFO - 'PWD': '/builds/slave/test', 10:00:18 INFO - 'SHELL': '/bin/bash', 10:00:18 INFO - 'SHLVL': '1', 10:00:18 INFO - 'TERM': 'linux', 10:00:18 INFO - 'TMOUT': '86400', 10:00:18 INFO - 'USER': 'cltbld', 10:00:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:18 INFO - '_': '/tools/buildbot/bin/python'} 10:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00:18 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 10:00:18 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 10:00:18 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 10:00:18 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 10:00:18 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 10:00:18 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 10:00:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:20 INFO - Installing collected packages: mozsystemmonitor 10:00:20 INFO - Running setup.py install for mozsystemmonitor 10:00:20 INFO - Successfully installed mozsystemmonitor 10:00:20 INFO - Cleaning up... 10:00:20 INFO - Return code: 0 10:00:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:20 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:20 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 10:00:20 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 10:00:20 INFO - Using env: {'DISPLAY': ':0', 10:00:20 INFO - 'HOME': '/home/cltbld', 10:00:20 INFO - 'LANG': 'en_US.UTF-8', 10:00:20 INFO - 'LANGUAGE': 'en_US:en', 10:00:20 INFO - 'LOGNAME': 'cltbld', 10:00:20 INFO - 'MAIL': '/var/mail/cltbld', 10:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:20 INFO - 'MOZ_NO_REMOTE': '1', 10:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:20 INFO - 'NO_EM_RESTART': '1', 10:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:20 INFO - 'PWD': '/builds/slave/test', 10:00:20 INFO - 'SHELL': '/bin/bash', 10:00:20 INFO - 'SHLVL': '1', 10:00:20 INFO - 'TERM': 'linux', 10:00:20 INFO - 'TMOUT': '86400', 10:00:20 INFO - 'USER': 'cltbld', 10:00:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:20 INFO - '_': '/tools/buildbot/bin/python'} 10:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:20 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:22 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 10:00:23 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:23 INFO - warning: no files found matching '*.txt' 10:00:23 INFO - no previously-included directories found matching 'build' 10:00:23 INFO - no previously-included directories found matching 'dist' 10:00:23 INFO - no previously-included directories found matching '.git*' 10:00:23 INFO - Installing collected packages: jsonschema, functools32 10:00:23 INFO - Running setup.py install for functools32 10:00:23 INFO - warning: no files found matching '*.txt' 10:00:23 INFO - no previously-included directories found matching 'build' 10:00:23 INFO - no previously-included directories found matching 'dist' 10:00:23 INFO - no previously-included directories found matching '.git*' 10:00:23 INFO - Successfully installed jsonschema functools32 10:00:23 INFO - Cleaning up... 10:00:23 INFO - Return code: 0 10:00:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:23 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 10:00:23 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 10:00:23 INFO - Using env: {'DISPLAY': ':0', 10:00:23 INFO - 'HOME': '/home/cltbld', 10:00:23 INFO - 'LANG': 'en_US.UTF-8', 10:00:23 INFO - 'LANGUAGE': 'en_US:en', 10:00:23 INFO - 'LOGNAME': 'cltbld', 10:00:23 INFO - 'MAIL': '/var/mail/cltbld', 10:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:23 INFO - 'MOZ_NO_REMOTE': '1', 10:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:23 INFO - 'NO_EM_RESTART': '1', 10:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:23 INFO - 'PWD': '/builds/slave/test', 10:00:23 INFO - 'SHELL': '/bin/bash', 10:00:23 INFO - 'SHLVL': '1', 10:00:23 INFO - 'TERM': 'linux', 10:00:23 INFO - 'TMOUT': '86400', 10:00:23 INFO - 'USER': 'cltbld', 10:00:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:23 INFO - '_': '/tools/buildbot/bin/python'} 10:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:00:23 INFO - Cleaning up... 10:00:23 INFO - Return code: 0 10:00:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:23 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:23 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 10:00:23 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 10:00:23 INFO - Using env: {'DISPLAY': ':0', 10:00:23 INFO - 'HOME': '/home/cltbld', 10:00:23 INFO - 'LANG': 'en_US.UTF-8', 10:00:23 INFO - 'LANGUAGE': 'en_US:en', 10:00:23 INFO - 'LOGNAME': 'cltbld', 10:00:23 INFO - 'MAIL': '/var/mail/cltbld', 10:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:23 INFO - 'MOZ_NO_REMOTE': '1', 10:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:23 INFO - 'NO_EM_RESTART': '1', 10:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:23 INFO - 'PWD': '/builds/slave/test', 10:00:23 INFO - 'SHELL': '/bin/bash', 10:00:23 INFO - 'SHLVL': '1', 10:00:23 INFO - 'TERM': 'linux', 10:00:23 INFO - 'TMOUT': '86400', 10:00:23 INFO - 'USER': 'cltbld', 10:00:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:23 INFO - '_': '/tools/buildbot/bin/python'} 10:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:23 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:23 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 10:00:23 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 10:00:23 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 10:00:23 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 10:00:23 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 10:00:23 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 10:00:25 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:26 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 10:00:26 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 10:00:26 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 10:00:26 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 10:00:26 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 10:00:26 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 10:00:26 INFO - Downloading docopt-0.6.1.tar.gz 10:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:26 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:26 INFO - Running setup.py install for blobuploader 10:00:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:26 INFO - Running setup.py install for requests 10:00:27 INFO - Running setup.py install for docopt 10:00:27 INFO - Successfully installed blobuploader requests docopt 10:00:27 INFO - Cleaning up... 10:00:27 INFO - Return code: 0 10:00:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:27 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:27 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 10:00:27 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 10:00:27 INFO - Using env: {'DISPLAY': ':0', 10:00:27 INFO - 'HOME': '/home/cltbld', 10:00:27 INFO - 'LANG': 'en_US.UTF-8', 10:00:27 INFO - 'LANGUAGE': 'en_US:en', 10:00:27 INFO - 'LOGNAME': 'cltbld', 10:00:27 INFO - 'MAIL': '/var/mail/cltbld', 10:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:27 INFO - 'MOZ_NO_REMOTE': '1', 10:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:27 INFO - 'NO_EM_RESTART': '1', 10:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:27 INFO - 'PWD': '/builds/slave/test', 10:00:27 INFO - 'SHELL': '/bin/bash', 10:00:27 INFO - 'SHLVL': '1', 10:00:27 INFO - 'TERM': 'linux', 10:00:27 INFO - 'TMOUT': '86400', 10:00:27 INFO - 'USER': 'cltbld', 10:00:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:27 INFO - '_': '/tools/buildbot/bin/python'} 10:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:27 INFO - Running setup.py (path:/tmp/pip-ihr5Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:27 INFO - Running setup.py (path:/tmp/pip-FYR00w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:27 INFO - Running setup.py (path:/tmp/pip-poMFXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:27 INFO - Running setup.py (path:/tmp/pip-Vnnjs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:27 INFO - Running setup.py (path:/tmp/pip-eorvcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:27 INFO - Running setup.py (path:/tmp/pip-RwgElC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:27 INFO - Running setup.py (path:/tmp/pip-mOz0yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:27 INFO - Running setup.py (path:/tmp/pip-BnuycO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:27 INFO - Running setup.py (path:/tmp/pip-3TWUxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:28 INFO - Running setup.py (path:/tmp/pip-QtBhDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:28 INFO - Running setup.py (path:/tmp/pip-2Cjm3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:28 INFO - Running setup.py (path:/tmp/pip-N5mJv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:28 INFO - Running setup.py (path:/tmp/pip-rmpHjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:28 INFO - Running setup.py (path:/tmp/pip-0knxi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:28 INFO - Running setup.py (path:/tmp/pip-4id_Yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:28 INFO - Running setup.py (path:/tmp/pip-SGVWK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:28 INFO - Running setup.py (path:/tmp/pip-dWPE0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:28 INFO - Running setup.py install for manifestparser 10:00:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:28 INFO - Running setup.py install for mozcrash 10:00:28 INFO - Running setup.py install for mozdebug 10:00:28 INFO - Running setup.py install for mozdevice 10:00:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozfile 10:00:29 INFO - Running setup.py install for mozhttpd 10:00:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozinfo 10:00:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozInstall 10:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozleak 10:00:29 INFO - Running setup.py install for mozlog 10:00:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for moznetwork 10:00:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozprocess 10:00:29 INFO - Running setup.py install for mozprofile 10:00:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:29 INFO - Running setup.py install for mozrunner 10:00:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:30 INFO - Running setup.py install for mozscreenshot 10:00:30 INFO - Running setup.py install for moztest 10:00:30 INFO - Running setup.py install for mozversion 10:00:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:30 INFO - Cleaning up... 10:00:30 INFO - Return code: 0 10:00:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:30 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')]} 10:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:30 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')]} 10:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:30 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:30 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 10:00:30 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 10:00:30 INFO - Using env: {'DISPLAY': ':0', 10:00:30 INFO - 'HOME': '/home/cltbld', 10:00:30 INFO - 'LANG': 'en_US.UTF-8', 10:00:30 INFO - 'LANGUAGE': 'en_US:en', 10:00:30 INFO - 'LOGNAME': 'cltbld', 10:00:30 INFO - 'MAIL': '/var/mail/cltbld', 10:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:30 INFO - 'MOZ_NO_REMOTE': '1', 10:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:30 INFO - 'NO_EM_RESTART': '1', 10:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:30 INFO - 'PWD': '/builds/slave/test', 10:00:30 INFO - 'SHELL': '/bin/bash', 10:00:30 INFO - 'SHLVL': '1', 10:00:30 INFO - 'TERM': 'linux', 10:00:30 INFO - 'TMOUT': '86400', 10:00:30 INFO - 'USER': 'cltbld', 10:00:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:30 INFO - '_': '/tools/buildbot/bin/python'} 10:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:30 INFO - Running setup.py (path:/tmp/pip-6hDF6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:30 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)) 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:30 INFO - Running setup.py (path:/tmp/pip-YcO3ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:30 INFO - Running setup.py (path:/tmp/pip-eWxM5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:30 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)) 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:30 INFO - Running setup.py (path:/tmp/pip-WDeK3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:30 INFO - Running setup.py (path:/tmp/pip-5hvRmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:30 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)) 10:00:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:30 INFO - Running setup.py (path:/tmp/pip-Pm4VIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:31 INFO - Running setup.py (path:/tmp/pip-blRFzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:31 INFO - Running setup.py (path:/tmp/pip-LNAVs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:31 INFO - Running setup.py (path:/tmp/pip-qNeKnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:31 INFO - Running setup.py (path:/tmp/pip-kc36pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:31 INFO - Running setup.py (path:/tmp/pip-QUiRMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:31 INFO - Running setup.py (path:/tmp/pip-d0X8oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:31 INFO - Running setup.py (path:/tmp/pip-MvDjPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:31 INFO - Running setup.py (path:/tmp/pip-QG8fRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:31 INFO - Running setup.py (path:/tmp/pip-6UVs6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:31 INFO - Running setup.py (path:/tmp/pip-jGMJJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:31 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)) 10:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:31 INFO - Running setup.py (path:/tmp/pip-hsCT6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:31 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)) 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:00:31 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)) 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:00:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:31 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 10:00:31 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 10:00:31 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 10:00:31 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 10:00:31 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 10:00:31 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 10:00:33 INFO - Downloading blessings-1.6.tar.gz 10:00:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:33 INFO - Installing collected packages: blessings 10:00:33 INFO - Running setup.py install for blessings 10:00:33 INFO - Successfully installed blessings 10:00:33 INFO - Cleaning up... 10:00:34 INFO - Return code: 0 10:00:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:34 INFO - Reading from file tmpfile_stdout 10:00:34 INFO - Current package versions: 10:00:34 INFO - argparse == 1.2.1 10:00:34 INFO - blessings == 1.6 10:00:34 INFO - blobuploader == 1.2.4 10:00:34 INFO - docopt == 0.6.1 10:00:34 INFO - functools32 == 3.2.3-2 10:00:34 INFO - jsonschema == 2.5.1 10:00:34 INFO - manifestparser == 1.1 10:00:34 INFO - mozInstall == 1.12 10:00:34 INFO - mozcrash == 0.17 10:00:34 INFO - mozdebug == 0.1 10:00:34 INFO - mozdevice == 0.48 10:00:34 INFO - mozfile == 1.2 10:00:34 INFO - mozhttpd == 0.7 10:00:34 INFO - mozinfo == 0.9 10:00:34 INFO - mozleak == 0.1 10:00:34 INFO - mozlog == 3.4 10:00:34 INFO - moznetwork == 0.27 10:00:34 INFO - mozprocess == 0.23 10:00:34 INFO - mozprofile == 0.28 10:00:34 INFO - mozrunner == 6.12 10:00:34 INFO - mozscreenshot == 0.1 10:00:34 INFO - mozsystemmonitor == 0.3 10:00:34 INFO - moztest == 0.7 10:00:34 INFO - mozversion == 1.4 10:00:34 INFO - psutil == 3.1.1 10:00:34 INFO - requests == 1.2.3 10:00:34 INFO - wsgiref == 0.1.2 10:00:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:34 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')]} 10:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:34 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')]} 10:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:34 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:34 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 10:00:34 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 10:00:34 INFO - Using env: {'DISPLAY': ':0', 10:00:34 INFO - 'HOME': '/home/cltbld', 10:00:34 INFO - 'LANG': 'en_US.UTF-8', 10:00:34 INFO - 'LANGUAGE': 'en_US:en', 10:00:34 INFO - 'LOGNAME': 'cltbld', 10:00:34 INFO - 'MAIL': '/var/mail/cltbld', 10:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:34 INFO - 'MOZ_NO_REMOTE': '1', 10:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:34 INFO - 'NO_EM_RESTART': '1', 10:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:34 INFO - 'PWD': '/builds/slave/test', 10:00:34 INFO - 'SHELL': '/bin/bash', 10:00:34 INFO - 'SHLVL': '1', 10:00:34 INFO - 'TERM': 'linux', 10:00:34 INFO - 'TMOUT': '86400', 10:00:34 INFO - 'USER': 'cltbld', 10:00:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:34 INFO - '_': '/tools/buildbot/bin/python'} 10:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 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)) 10:00:34 INFO - Cleaning up... 10:00:34 INFO - Return code: 0 10:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:34 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')]} 10:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:34 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')]} 10:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:00:34 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 0x7fb7e5d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22be8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x238bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', '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 10:00:34 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 10:00:34 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 10:00:34 INFO - Using env: {'DISPLAY': ':0', 10:00:34 INFO - 'HOME': '/home/cltbld', 10:00:34 INFO - 'LANG': 'en_US.UTF-8', 10:00:34 INFO - 'LANGUAGE': 'en_US:en', 10:00:34 INFO - 'LOGNAME': 'cltbld', 10:00:34 INFO - 'MAIL': '/var/mail/cltbld', 10:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:34 INFO - 'MOZ_NO_REMOTE': '1', 10:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:34 INFO - 'NO_EM_RESTART': '1', 10:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:34 INFO - 'PWD': '/builds/slave/test', 10:00:34 INFO - 'SHELL': '/bin/bash', 10:00:34 INFO - 'SHLVL': '1', 10:00:34 INFO - 'TERM': 'linux', 10:00:34 INFO - 'TMOUT': '86400', 10:00:34 INFO - 'USER': 'cltbld', 10:00:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:34 INFO - '_': '/tools/buildbot/bin/python'} 10:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:34 INFO - Cleaning up... 10:00:34 INFO - Return code: 0 10:00:34 INFO - Running post-action listener: _resource_record_post_action 10:00:34 INFO - Running post-action listener: _start_resource_monitoring 10:00:34 INFO - Starting resource monitoring. 10:00:34 INFO - [mozharness: 2016-10-21 17:00:34.742767Z] Finished create-virtualenv step (success) 10:00:34 INFO - [mozharness: 2016-10-21 17:00:34.743266Z] Running install step. 10:00:34 INFO - Running pre-action listener: _resource_record_pre_action 10:00:34 INFO - Running main action method: install 10:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:34 INFO - Reading from file tmpfile_stdout 10:00:34 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:35 INFO - Reading from file tmpfile_stdout 10:00:35 INFO - Output received: 10:00:35 INFO - Usage: mozinstall [options] installer 10:00:35 INFO - Options: 10:00:35 INFO - -h, --help show this help message and exit 10:00:35 INFO - -d DEST, --destination=DEST 10:00:35 INFO - Directory to install application into. [default: 10:00:35 INFO - "/builds/slave/test"] 10:00:35 INFO - --app=APP Application being installed. [default: firefox] 10:00:35 INFO - mkdir: /builds/slave/test/build/application 10:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:00:51 INFO - Reading from file tmpfile_stdout 10:00:51 INFO - Output received: 10:00:51 INFO - /builds/slave/test/build/application/firefox/firefox 10:00:51 INFO - Running post-action listener: _resource_record_post_action 10:00:51 INFO - [mozharness: 2016-10-21 17:00:51.939046Z] Finished install step (success) 10:00:51 INFO - [mozharness: 2016-10-21 17:00:51.939323Z] Running run-tests step. 10:00:51 INFO - Running pre-action listener: _resource_record_pre_action 10:00:51 INFO - Running main action method: run_tests 10:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:51 INFO - Python 2.7.3 10:00:51 INFO - Return code: 0 10:00:51 INFO - grabbing minidump binary from tooltool 10:00:51 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')]} 10:00:51 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 0x2388f60>, '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 0x2389d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x238a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:51 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 10:00:51 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 10:00:51 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 10:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:52 INFO - Return code: 0 10:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:52 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:00:52 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:00:52 INFO - Using env: {'DISPLAY': ':0', 10:00:52 INFO - 'HOME': '/home/cltbld', 10:00:52 INFO - 'LANG': 'en_US.UTF-8', 10:00:52 INFO - 'LANGUAGE': 'en_US:en', 10:00:52 INFO - 'LOGNAME': 'cltbld', 10:00:52 INFO - 'MAIL': '/var/mail/cltbld', 10:00:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:52 INFO - 'MOZ_NO_REMOTE': '1', 10:00:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:52 INFO - 'NO_EM_RESTART': '1', 10:00:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:52 INFO - 'PWD': '/builds/slave/test', 10:00:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:52 INFO - 'SHELL': '/bin/bash', 10:00:52 INFO - 'SHLVL': '1', 10:00:52 INFO - 'TERM': 'linux', 10:00:52 INFO - 'TMOUT': '86400', 10:00:52 INFO - 'USER': 'cltbld', 10:00:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232', 10:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:52 INFO - '_': '/tools/buildbot/bin/python'} 10:00:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:00:52 INFO - mozversion application_buildid: 20161021081107 10:00:52 INFO - mozversion application_changeset: 806054dd12bdcbdee81dbd75f1583156cef9b649 10:00:52 INFO - mozversion application_display_name: Nightly 10:00:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:52 INFO - mozversion application_name: Firefox 10:00:52 INFO - mozversion application_remotingname: firefox 10:00:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:52 INFO - mozversion application_vendor: Mozilla 10:00:52 INFO - mozversion application_version: 52.0a1 10:00:52 INFO - mozversion platform_buildid: 20161021081107 10:00:52 INFO - mozversion platform_changeset: 806054dd12bdcbdee81dbd75f1583156cef9b649 10:00:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:00:52 INFO - mozversion platform_version: 52.0a1 10:00:52 INFO - using testdate: 1477069252 10:00:52 INFO - actual date: 1477069252 10:00:52 INFO - starting webserver on 'localhost:46046' 10:00:52 INFO - SUITE-START | Running 2 tests 10:00:52 INFO - TEST-START | dromaeo_css 10:00:52 INFO - operating with platform_type : linux_ 10:00:52 INFO - Initialising browser for dromaeo_css test... 10:00:52 INFO - TEST-INFO | started process 16924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOYkq3l/profile http://localhost:46046/getInfo.html) 10:00:56 INFO - PROCESS | 16924 | __metrics Screen width/height:1600/1200 10:00:56 INFO - PROCESS | 16924 | colorDepth:24 10:00:56 INFO - PROCESS | 16924 | Browser inner width/height: 1024/697 10:00:56 INFO - PROCESS | 16924 | __metrics 10:00:57 ERROR - PROCESS | 16924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:00:58 INFO - TEST-INFO | 16924: exit 0 10:00:58 INFO - Browser initialized. 10:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:58 INFO - TEST-INFO | started process 17047 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOYkq3l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:10 INFO - PROCESS | 17047 | RSS: Main: 182255616 10:01:10 INFO - PROCESS | 17047 | 10:02:00 INFO - PROCESS | 17047 | 1477069320000 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] 10:04:10 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46046/tests/dromaeo/cssquery-ext.html) 10:04:12 INFO - PROCESS | 17047 | RSS: Main: 195887104 10:04:12 INFO - PROCESS | 17047 | 10:07:14 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-ext.html (next: http://localhost:46046/tests/dromaeo/cssquery-jquery.html) 10:07:14 INFO - PROCESS | 17047 | RSS: Main: 194441216 10:07:14 INFO - PROCESS | 17047 | 10:10:16 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46046/tests/dromaeo/cssquery-mootools.html) 10:10:17 INFO - PROCESS | 17047 | RSS: Main: 196648960 10:10:17 INFO - PROCESS | 17047 | 10:13:19 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46046/tests/dromaeo/cssquery-prototype.html) 10:13:19 INFO - PROCESS | 17047 | RSS: Main: 193564672 10:13:19 INFO - PROCESS | 17047 | 10:16:22 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46046/tests/dromaeo/cssquery-yui.html) 10:16:23 INFO - PROCESS | 17047 | RSS: Main: 197099520 10:16:23 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | Cycle 1(1): loaded http://localhost:46046/tests/dromaeo/cssquery-yui.html (next: http://localhost:46046/tests/dromaeo/cssquery-dojo.html) 10:19:26 INFO - PROCESS | 17047 | RSS: Main: 197083136 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | __start_tp_report 10:19:26 INFO - PROCESS | 17047 | _x_x_mozilla_page_load 10:19:26 INFO - PROCESS | 17047 | _x_x_mozilla_page_load_details 10:19:26 INFO - PROCESS | 17047 | |i|pagename|runs| 10:19:26 INFO - PROCESS | 17047 | |0;dojo.html;3038.9544156837637;3099.7365223955967;3105.130563442237;3117.438861005018;3142.324400253945;5269.710165940881;5293.232481290215;5324.387695415024;5393.352797664285;5442.054689955549;5304.098303288441;5312.442193569668;5368.1679339702405;5424;5433.429489903562;4864.610831133518;4898.338724272231;4926.45808961014;4945.7774400152075;4956.801727930879;4911.729854857981;4988.950110498903;5006.349174607296;5014.2979982802435;5051.343325367697;4820.903581928377;4875.878103047452;4881.536254055859;4924.852254432372;4926.704397736129;4887.975560122212;4920.655554111214;4943.728094954776;4986.077575648516;5001.949980500185;4874.829380971649;4894.535019173173;4900.6569540132205;4926.0394223126505;4983.377077865267;5281.234221037967;5314.707691076989;5354.919676204821;5396.784128634889;5407.783688652449;5654.123610840326;5755.597108202427;5776.075827867521;5790.131480277992;5862.443067908542;5774.422557744192;5808.738606762706;5813.331466881278;5821.708914554255;5825.388334224887;5307.973460132752;5374.247605335178;5409.43200963901;5415.675059496403;5420.837374878721;5789.623674461231;5881.882362352814;5915.290165180206;5944.464998150187;6011.48902343297;5702.087665973424;5708.372079071299;5716.742746576414;5721.799737009184;5724;5696.914546281809;5774.133879918046;5800.622959507703;5805.187273781674;5820.35976042635;5610.49505544503;5685.715714214272;5707.0583353747;5708.885822283531;5715.2855893013375;5755.3381361144;5758.913616295759;5761.251037365116;5763.8559036024435;5808.506276966421;4320.481542214891;4369.191699535596;4371.388005679208;4376.452943382077;4426.601605855489;3868.4777555030273;3892.4355968384425;3905.3751399776465;3918.7060970427333;3955.110100227426;5519.3652729936575;5549.916751248735;5559.388467268597;5596.832095037155;5618.213450116987;5794.652320860761;5847.386024467455;5852.326982396994;5868.823935281948;5872.941270587325;5256;5406.702631355234;5433.565314774809;5472.534834539029;5540.473655002768;4786.617070634341;4787.114383839001;4816.903661926742;4834.927476087792;4838.274258861199;5848.152017957373;5849.473547380756;5863.941360586425;5864.501517371071;5905.675187864708;5638.182463542681;5739.110437882135;5754.3382511010095;5781.768729250783;5789.421057894177;5841.678707671119;5928.525717942641;5974.462298393166;5992.820215393545;6052.606580572248;5687.829365119053;5721.399253078534;5738.167965644875;5742;5746.367899530965;5779.884402312015;5806.738696758572;5826.329972053268;5837.503812176013;5850;5537.667739935617;5594.496495315441;5600.963821692837;5644.3508996465935;5664.405237450009;5518.089515229942;5615.157726341082;5620.213170156263;5621.381648018633;5631.183478395527;5555.166724991283;5568.693721845176;5579.972100139636;5582.49757521825;5601.747921343631;5664.235328230636;5738.799142030176;5743.74153163117;5750.654960702204;5793.333766616893;5597.076482380362;5614.719264036864;5615.129654903497;5615.157726341082;5617.129344951539 10:19:26 INFO - PROCESS | 17047 | |1;ext.html;566.3232437237501;588.5879884081145;593.6705128653598;600.3216365506977;601.4586871815366;40838.18323633526;42508.78745606272;42666.14667706644;45495.317570236475;45623.77188114063;42376;42397.57602423975;42695.78652106743;42724.14551708972;43041.56958430415;8672.262857657091;8736.257418119467;8747.737567872973;8807.603657835412;8812.779680507974;8569.871451928226;8574.78563035926;8666.176713212235;8708.129187081273;8714.389992700513;8619.1811777881;8694.304455643532;8694.434861733967;8699.086595907433;8740.562971851383;8598.140185981352;8619.95690021549;8625.051244363114;8657;8714.259287960562;8494.320454363637;8556.914430855673;8562.700305489278;8578.871316930252;8617.267532259766;39780.20439591221;40136.799316003526;40198.79900600507;40207;40308.39537406941;3324.501324801275;3355.4966754986704;3467.0638927489435;3545.62770909056;3729.5710993235853;29216.269593260127;29951.700482995107;30134;30198.69801301981;30253.394932101455;4153.54311025787;4222.5566315536735;4275.498907937669;4397.719848588361;4481.417415735966;211821;212644;212797;214490;215274.99999999843;53803;53822.46485492034;54424.18363724547;54455.18317225245;54456.45543544514;57041;57185.42814571884;57395;57453.71273143608;57540.71229643909;13605.523806666719;13672.726545469035;13756;13759.96800239986;13860.653483662989;10866.945665271782;10884.673459796219;10910.072643825206;10925.781484370427;10950.288231264942;12681.429335679917;16171.919140404223;16178.19109044543;16240.350385984664;16460.341586336654;3045.786794924334;3113.501839705636;5568.220449137124;5759.1937128802;5793.159991801165;892.7500299916034;964.2912459342377;1000.8798944126606;1018.9490525473697;1112.8386383974278;30521.542176867366;30546.516437352806;30656.62045207971;31069.844650776602;31353.686463135076;1079.3955384984276;1085.2457542008228;1123.4944275076248;1135.2677522997785;1139.4075080957855;15909.306754507448;15935.442259520862;16381.344746210018;16430.26359192749;16805.747913781302;498690;502414;503392;506336.619802813;507137;55119.72440137774;55525.16712249319;55618.44381556214;55801.44198558044;55804.44195558074;1272.1540175783;1301.2127662763892;1316.960491185266;1319.4128612767227;1319.4194554396227;29328.41343173167;30095;30757.23106922345;30889;31290.687093129687;49116;49302.75348623234;49601;49665.50334496753;49729.50270497249;405918;409529;409915;412029;412470;24768.380790480383;24972.37569060788;25005;25039.499210015332;25306.481611103394;44802.3279650799;45160;45347.77326113348;46049.30926036045;46962.29556556586;37495.43756843595;38914;39131.41302880516;39712.80143599264;41328.79335603303;35951.64048359483;38378.89160961516;38698.80650596729;39484.40773388344;40619.59380406158;39821.60178398179;40148.1970360597;40696.593034070465;40814.79592602018;40898.182036358514;33370.66629333773;35332.24476791636;35930.4610430849;36510.63489365178;36714.26571468609;27010.594841077007;27064.729352707007;27379.178624641292;27540.862295689196;27543.86228068927 10:19:26 INFO - PROCESS | 17047 | |2;jquery.html;365.09638644355226;369.46427679864195;371.2704535587571;381.7325088971511;390.5918315360448;17901.731474027885;18654.813451865477;18740.90629546852;19392.51518712033;19575.902120489412;18099.28510723392;18232.361867334646;18953.147108380123;18954.431367058976;19160.80839191611;5097.388313402387;5174.80979374744;5292.92060619091;5300.840974770763;5309.097453432906;4261.829526818923;5264.42091369949;5303.946960530384;5304.045271851065;5306.124489459254;5284.445133260991;5289.233061206123;5299.814506492274;5306.7346632668405;5311.1502159654465;5382.757775900094;5628.662280263197;5682.232898558725;5733.397993210736;5737.454941780524;5334.599905007101;5352.705601191933;5550.27846379972;5555.194496797942;5564.972175139139;11795;11822.349770762605;11935.104867135;11950.701232469259;11951.760964780742;2161.8162456191244;2231.274835678395;2248.303026061926;2289.8511596746325;2361.8700971446565;9609.759756006086;9920.156786673142;10476.58093676252;10582.153427725763;11693.415329233589;1911.9044047797554;1924.769027716683;1953.7850836407983;1971.960560788776;1989.1645508886302;76723.6163819183;80717.59641201815;81649.59175204145;82778.58610706907;83853;10287;10376.844347334796;10609.734756631146;10669.253152279265;10879.401632910107;14823.332950017275;14860.851391486163;14870.70258594822;14876.256187190596;14922;6999.545029573062;7323.084614423197;7368.4842061055215;7473.738419155304;7601.885971710429;6963.408110310579;6991.335823096798;7102.325279098477;7127.358537731526;7222.205557388683;4460.1525710114975;4470.508244093147;4528.818847246073;4661.114388266218;4707.7881495332795;1884.1615481110773;1977.3870100268962;1998.810113039259;2027;2031.2687432524278;891.8171774786153;1004.2869562610629;1051.9053285204368;1053;1057.6192570674705;18388.540286492946;18440;18647.627047458976;18688.68769276678;19297.324593639154;941.4398432932394;951.2770294576034;952.5903861339552;986.6877053518803;988.2588058955783;10034.949825250973;10602.628907988337;10665.573377064986;10700.090492308242;10776;457428;463433;463763;466092;466226;50386;86545.5672721645;88368;88631.55684221537;89940.10059899317;939.6241503398559;953.0088707744007;969.3214749675255;993.7118235711707;999.7900440907491;16074.839251607335;16213.432529861399;16327;16656.666866662843;16821.990680559207;38124;38901.22197555976;39978;40138.598614013485;41050.1789964205;54586.45413545814;55273.72363138159;56143.71928140333;56823;58611;7979.880301795361;8156.632951517077;8269.586520673822;8441.451305665112;8529.14708529142;9382.95308523453;12353.197042192589;12712.491500340253;12935;13286.402111905181;10990.780184396428;11284.774304514029;11358.602448914578;11365.943170284427;11874.168808183344;11341.829872552084;11395.430228488709;11443.370614616277;11512.769744605228;11655.358955257543;11190.664280071285;11224.494897729784;11373.260738052;11413.771724565628;11549.711257218636;8183.918160818554;8311.584420778816;8334.291585215324;8430.199131082538;8579.571021449028;9485.810283794424;11346.205765596329;11438.71403214893;11482;11979.507684618267 10:19:26 INFO - PROCESS | 17047 | |3;mootools.html;1448.7537118689825;1464.941402343906;1574.7086788944046;1691.2304901269924;1736.3835838277403;7790.259925307087;8021.879671804913;8484.703035393763;9147.359684822057;9154.130357616032;8413.831723365543;8709.520976346314;8723.825523489526;8879.911200888006;8922.92924849019;2165.4261620670536;2225.2322948582796;2225.643896976484;2230;2233.3076746208644;2140.9250676226334;2171.185805323004;2225.5660146271484;2231.8995645195923;2236.4408897775556;2199.164317559333;2220.0897631970897;2227.866328020316;2242;2247.269637367862;2152.2467136502255;2154.0306861912204;2157.9892100539396;2173.7500187478404;2182.770809065049;2140.518383363746;2164.8376371772024;2187.595294870438;2196.000819627066;2201.8458707890454;8941.687040953535;9092;9092.545372731336;9092.545372731403;9111.088891110901;4974.602031837444;5026.698398096126;5063.569596584295;5070.898582028376;5094.286799848024;3126.546650735653;3236.288016636336;3261.2010057536054;3278.639349671534;3292.818894960776;1037.8962103789636;1071.8660167479065;1075.6826736112866;1093.775775965925;1117.5585643670786;11888.108391870644;11890.643280701594;11915.82126268098;11942.223755455867;12000.039996800322;3970.166265084307;4400.339949007611;4407.074514351958;4416.271315232951;4426.22541055314;10233.283670143019;10236.948815255875;10240.743981400525;10255.07704306601;10294.485275736184;5077.949220507821;5124.666896651705;5127.256547800623;5129.1793313070475;5136.794528218904;4053.310937140693;4658.3711198988385;4659.743714095689;4671.95328046722;4681.461631912305;3832.770033797981;3902.921941561153;3950.4469374287623;3967.7619342838943;4015.0765323975647;1221.712897469094;1224.797908345113;1225.4607972492254;1228.6989687526614;1232.7596118756755;889.9110088991049;917.1378903830378;920.1442658327819;941.5010044676333;951.8714973478492;5797;5886.8822623547285;5893.410658934073;5946.732397042144;6286.779962701284;890.5013192612029;941.8493041113526;955.8805149356331;971.5579411367811;973.3819024919086;3660.743747937619;3998.480197574355;4018.7387819792207;4073.165001174752;4101.2207680540605;10857.619983300547;11484.253523520945;11521.53913843437;11523.654290371302;11527.76944461106;11472.598459053894;11487;11487.138464615187;11487.885121148849;11490.597829075943;7350.154732205865;7626.580538070349;7939.483933544301;7983.600819958979;8033.638486268132;5806.129080637769;5922.674252916131;5953.821385358447;6000.609960352563;6072.666003369857;9649.083337082966;9994.450305233282;10047.296689231684;10116.443595602312;10143.543540540546;10036.397816130764;10141.695749127539;10176.796464070825;10270.6405275815;10301.587936482456;7693;7704.807379815549;7843.882341764764;7856.332211762065;7932.960335198287;8350.791230219293;8393.95803020981;8445.577721114043;8447.859538962162;8454.450460720034;7302.890456643261;7538.3969282458365;7630.923690763243;7753.961230194039;7947.5231486111015;7461.253874612496;7471.738489152854;7516.774496765106;7540.057492813398;7630.809229769078;6910.654467276516;6996.650167491707;7007.089078419773;7020.508564400443;7075.646217689198;5082.390113186441;5107.259447380184;5113.437521872516;5169.353830771153;5364.731763411735;5111.897762044812;5159.974200128975;5259.526642602184;5297.788088476572;5306.602004849575 10:19:26 INFO - PROCESS | 17047 | |4;prototype.html;320.87165133946417;324.5245715027486;331.4713032712823;336.68856307915155;338.4973314627779;5477.726113694314;5521.4478552144765;5532.889342213153;5540.612157149001;5543.750531226095;5415.187721841726;5418.485243901833;5429.294191755076;5432.483914028161;5468.234447177399;3990.241854047736;4118;4147.191297696951;4197.874063778091;4237.364395340693;4249.405083288342;4256.127493863751;4262.808173632194;4278.893027674302;4305.526392096866;4200.51694055183;4234.364845273203;4254.319543780205;4271.373105540086;4280.507741609708;4013.3377992631326;4182.498100227962;4196.433481479991;4253.043599944014;4257.318828987378;3689.206820533598;3694.224212915291;3705.46223317323;3712.6658600725796;3713.554373475173;5365.734241278194;5369.335505993155;5376.51611354976;5431.51116399522;5451.37309209442;4547.18150732868;4769.95230047702;4792.400949881265;4832.081904438181;4849.272609108627;5666.943330566683;5675.5459563234845;5676.33212390176;5762.3373312069225;5795.913061304083;4018.477597912282;4027.556968733437;4030.717849750519;4034.09232922593;4045.1505183911413;5896.525868532867;5897.380775018604;5928.7332070056955;5963.79552415546;6001.789937352171;4075.2053349597136;4107.753534787863;4109.8972525687095;4122.299209134394;4132.896677583084;4174.874753757392;4178.370435530146;4178.8328466860985;4187.225363307798;4212.557681443465;4669;4768.9523104769205;4807.711537307773;4815.759212039454;4842.806287748451;5752.511036561856;5771.278590176228;5772.797952071657;5810.448007439287;5817.970910145422;1430.3491911180388;1440.4958264607512;1446.6473846953133;1449.6086056764825;1451.520998070634;893.848045832197;906.51501446727;921.3090182363228;924.4176169013479;927.3879239701764;5448.291722076105;5453.590980676465;5486.780528778884;5501.257330260443;5547.223388725582;5840.2991641003355;5841.503472204825;5865.530757539386;5921.555883308769;5932.79235226765;5405.675659460445;5430.778074933188;5446.564274858002;5451.945480545223;5608.775648974077;3051.862666180027;3103.177657920653;3108.7668424867775;3131.373725254958;3148.622165340174;5754.942450575524;6008.879822403527;6037.78867739627;6064.3935606439;6069.544784141207;6011.909821352596;6046.244219472566;6085.04472093143;6092.72582733778;6101.633901965896;6111.724972376253;6118.674903536627;6118.724657390429;6119.449249567471;6148.508119350441;5617.483279514427;5885.058390657474;5943.7028148591535;5957.791477298274;5998.780451233071;5869.53043756507;5918.408159184047;5936.851578710567;5944.910826337522;5972.970135149297;5847;6139.373066137567;6179.5056395489155;6217.533684973736;6223.222097237845;4130.504339479162;4135.97932010338;4139.875803725893;4173.895652608588;4174.415581818608;6034.969825150846;6036.6679832609625;6052;6054.636721796706;6062.666213433037;5685.573581981285;5838.912416313844;5859.56053296013;5881.882362352643;5974.506373406648;5813.912791308049;5837.307180917486;5852.707364631666;5864.824055278348;5886.558508111994;5412.943081628956;5760.164776107525;5771.68255745938;5800.462877337593;5829;5779.450952159538;5826;5844.970775146097;5854.590178687451;5880.676562789087;5698.971505142447;5713.800016999385;5718.770464350185;5723.914141287967;5725.656460612377 10:19:26 INFO - PROCESS | 17047 | |5;yui.html;708.5996412027205;717.4153065251819;758.3705524414736;777.4596655324548;821.7288294862695;15513.689726205483;16722.163891805423;16753.916230418832;16761.1619419029;16789.83210167901;15979.840201597981;16095.517134485955;16111.677766444664;16183;16254.349826006975;747.6112421540796;770.6339488742858;771.1594362145261;776.3439893290189;796.3151689546985;790.4308897593723;792.3304807437706;796.77690246731;798.4849771897123;799.9680012799481;824.2416976381713;828.2628460670009;829.0300348592132;830.0744669693279;832.0930186097153;813.2314962360572;814.226484839405;814.7189219719187;817.6851912013917;821.0885916632533;600.261678135891;600.8377738010713;601.362555690969;603.1104121420913;603.432773193197;15067.321970511244;15075.773863392058;15120.621984450367;15200.16399098049;15219.239038048054;14331.681189543617;14442.470477583827;14461.49384771528;14463.493777717835;14566.854331456656;11744.94127529357;11814.763704725943;11869.94065029678;11880;12718.236905785683;3758.5291417512453;3789.5263092113487;3849.441830934527;3864.8647297344737;3998.520177578709;78390.21609783944;78885;79179.20820791833;79823.60088199521;80699.99999999942;10806.891931080589;11238.21332506733;11280.830787538194;11394.1454390921;11533;21396.251131210334;21401.143954241656;21428.678569821153;21574.89212553927;21606.89196554007;7973.322267607203;8053;8193.139720329398;8317;8520.616572254263;4584.6561507887045;4858.902821943541;4883.658143929891;4977.038661996106;5254.0805359062015;3502.9649703502637;3593.8562457501407;3646.799426031541;3664.780113193217;3671.3391589514144;585.1281590430314;605.6910975402576;612.5620181570199;622.6170904893457;630.8485963368759;642.6658137768428;656.0978654350268;666.7632990288474;675.166169780321;678.3453966921944;9421.38760980534;9497.762555936157;9510.1440870322;9878.802423951482;10243.795124097476;647.4270270810273;670.9496787740939;678.803147087349;681.8227260912099;715.3954908102749;4332.371806088163;4557.270836666117;4836.975815120973;5045.142325804622;5073.441921388644;119178;119635.40182299033;122872.77127228792;124977.37511312567;128355;70615;105944.99999999846;107667;109262.45368773265;109513.45243273892;74777;88854.55572722096;90940.54529727309;91562.54218728864;92343.5382823095;8910.331725120512;9282.62869485213;9312.534373281444;9509.952450237704;9638.614455421985;44757.77621111873;47378.76310618425;48128.759356202994;50318;52072.73963630158;65542.34457655363;72476.63761681369;73007.63496182485;73362.26637733555;77367.61316193383;10543.894561054598;10811.783764324828;10853.620123295646;11138.777224455303;11217.383043932661;12988.35058247065;13378.331083445983;13665.658358541115;13934.30328483592;14117.505887293895;13142.868571314164;13329.266890321125;14057.507987220808;14083.084599501;14109.788353174505;12665.303408312262;12816.935915320364;13011.544595939096;14192.645183870485;14199.716005679622;12510.499580016698;13044.934775326063;13083.672908177372;13205.141665791693;13211.867881321448;9922.305438619227;9948.900510994798;9977;10168.135708464863;10239.948800255952;9252.861207082035;9640.662576809778;10165.949170254102;10335.94832025835;10442.63450779219 10:19:26 INFO - PROCESS | 17047 | __end_tp_report 10:19:26 INFO - PROCESS | 17047 | __start_cc_report 10:19:26 INFO - PROCESS | 17047 | _x_x_mozilla_cycle_collect,304 10:19:26 INFO - PROCESS | 17047 | __end_cc_report 10:19:26 INFO - PROCESS | 17047 | __startTimestamp1477070366869__endTimestamp 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | ------- Summary: start ------- 10:19:26 INFO - PROCESS | 17047 | Number of tests: 6 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#0] dojo.html Cycles:165 Average:5358.43 Median:5600.96 stddev:616.79 (11.0%) stddev-sans-first:591.23 10:19:26 INFO - PROCESS | 17047 | Values: 3039.0 3099.7 3105.1 3117.4 3142.3 5269.7 5293.2 5324.4 5393.4 5442.1 5304.1 5312.4 5368.2 5424.0 5433.4 4864.6 4898.3 4926.5 4945.8 4956.8 4911.7 4989.0 5006.3 5014.3 5051.3 4820.9 4875.9 4881.5 4924.9 4926.7 4888.0 4920.7 4943.7 4986.1 5001.9 4874.8 4894.5 4900.7 4926.0 4983.4 5281.2 5314.7 5354.9 5396.8 5407.8 5654.1 5755.6 5776.1 5790.1 5862.4 5774.4 5808.7 5813.3 5821.7 5825.4 5308.0 5374.2 5409.4 5415.7 5420.8 5789.6 5881.9 5915.3 5944.5 6011.5 5702.1 5708.4 5716.7 5721.8 5724.0 5696.9 5774.1 5800.6 5805.2 5820.4 5610.5 5685.7 5707.1 5708.9 5715.3 5755.3 5758.9 5761.3 5763.9 5808.5 4320.5 4369.2 4371.4 4376.5 4426.6 3868.5 3892.4 3905.4 3918.7 3955.1 5519.4 5549.9 5559.4 5596.8 5618.2 5794.7 5847.4 5852.3 5868.8 5872.9 5256.0 5406.7 5433.6 5472.5 5540.5 4786.6 4787.1 4816.9 4834.9 4838.3 5848.2 5849.5 5863.9 5864.5 5905.7 5638.2 5739.1 5754.3 5781.8 5789.4 5841.7 5928.5 5974.5 5992.8 6052.6 5687.8 5721.4 5738.2 5742.0 5746.4 5779.9 5806.7 5826.3 5837.5 5850.0 5537.7 5594.5 5601.0 5644.4 5664.4 5518.1 5615.2 5620.2 5621.4 5631.2 5555.2 5568.7 5580.0 5582.5 5601.7 5664.2 5738.8 5743.7 5750.7 5793.3 5597.1 5614.7 5615.1 5615.2 5617.1 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#1] ext.html Cycles:180 Average:53589.00 Median:223268.80 stddev:104956.46 (47.0%) stddev-sans-first:105175.39 10:19:26 INFO - PROCESS | 17047 | Values: 566.3 588.6 593.7 600.3 601.5 40838.2 42508.8 42666.1 45495.3 45623.8 42376.0 42397.6 42695.8 42724.1 43041.6 8672.3 8736.3 8747.7 8807.6 8812.8 8569.9 8574.8 8666.2 8708.1 8714.4 8619.2 8694.3 8694.4 8699.1 8740.6 8598.1 8620.0 8625.1 8657.0 8714.3 8494.3 8556.9 8562.7 8578.9 8617.3 39780.2 40136.8 40198.8 40207.0 40308.4 3324.5 3355.5 3467.1 3545.6 3729.6 29216.3 29951.7 30134.0 30198.7 30253.4 4153.5 4222.6 4275.5 4397.7 4481.4 211821.0 212644.0 212797.0 214490.0 215275.0 53803.0 53822.5 54424.2 54455.2 54456.5 57041.0 57185.4 57395.0 57453.7 57540.7 13605.5 13672.7 13756.0 13760.0 13860.7 10866.9 10884.7 10910.1 10925.8 10950.3 12681.4 16171.9 16178.2 16240.4 16460.3 3045.8 3113.5 5568.2 5759.2 5793.2 892.8 964.3 1000.9 1018.9 1112.8 30521.5 30546.5 30656.6 31069.8 31353.7 1079.4 1085.2 1123.5 1135.3 1139.4 15909.3 15935.4 16381.3 16430.3 16805.7 498690.0 502414.0 503392.0 506336.6 507137.0 55119.7 55525.2 55618.4 55801.4 55804.4 1272.2 1301.2 1317.0 1319.4 1319.4 29328.4 30095.0 30757.2 30889.0 31290.7 49116.0 49302.8 49601.0 49665.5 49729.5 405918.0 409529.0 409915.0 412029.0 412470.0 24768.4 24972.4 25005.0 25039.5 25306.5 44802.3 45160.0 45347.8 46049.3 46962.3 37495.4 38914.0 39131.4 39712.8 41328.8 35951.6 38378.9 38698.8 39484.4 40619.6 39821.6 40148.2 40696.6 40814.8 40898.2 33370.7 35332.2 35930.5 36510.6 36714.3 27010.6 27064.7 27379.2 27540.9 27543.9 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#2] jquery.html Cycles:180 Average:27266.00 Median:19645.91 stddev:76438.04 (389.1%) stddev-sans-first:76625.78 10:19:26 INFO - PROCESS | 17047 | Values: 365.1 369.5 371.3 381.7 390.6 17901.7 18654.8 18740.9 19392.5 19575.9 18099.3 18232.4 18953.1 18954.4 19160.8 5097.4 5174.8 5292.9 5300.8 5309.1 4261.8 5264.4 5303.9 5304.0 5306.1 5284.4 5289.2 5299.8 5306.7 5311.2 5382.8 5628.7 5682.2 5733.4 5737.5 5334.6 5352.7 5550.3 5555.2 5565.0 11795.0 11822.3 11935.1 11950.7 11951.8 2161.8 2231.3 2248.3 2289.9 2361.9 9609.8 9920.2 10476.6 10582.2 11693.4 1911.9 1924.8 1953.8 1972.0 1989.2 76723.6 80717.6 81649.6 82778.6 83853.0 10287.0 10376.8 10609.7 10669.3 10879.4 14823.3 14860.9 14870.7 14876.3 14922.0 6999.5 7323.1 7368.5 7473.7 7601.9 6963.4 6991.3 7102.3 7127.4 7222.2 4460.2 4470.5 4528.8 4661.1 4707.8 1884.2 1977.4 1998.8 2027.0 2031.3 891.8 1004.3 1051.9 1053.0 1057.6 18388.5 18440.0 18647.6 18688.7 19297.3 941.4 951.3 952.6 986.7 988.3 10034.9 10602.6 10665.6 10700.1 10776.0 457428.0 463433.0 463763.0 466092.0 466226.0 50386.0 86545.6 88368.0 88631.6 89940.1 939.6 953.0 969.3 993.7 999.8 16074.8 16213.4 16327.0 16656.7 16822.0 38124.0 38901.2 39978.0 40138.6 41050.2 54586.5 55273.7 56143.7 56823.0 58611.0 7979.9 8156.6 8269.6 8441.5 8529.1 9383.0 12353.2 12712.5 12935.0 13286.4 10990.8 11284.8 11358.6 11365.9 11874.2 11341.8 11395.4 11443.4 11512.8 11655.4 11190.7 11224.5 11373.3 11413.8 11549.7 8183.9 8311.6 8334.3 8430.2 8579.6 9485.8 11346.2 11438.7 11482.0 11979.5 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#3] mootools.html Cycles:180 Average:5748.42 Median:4665.85 stddev:3341.64 (71.6%) stddev-sans-first:3335.39 10:19:26 INFO - PROCESS | 17047 | Values: 1448.8 1464.9 1574.7 1691.2 1736.4 7790.3 8021.9 8484.7 9147.4 9154.1 8413.8 8709.5 8723.8 8879.9 8922.9 2165.4 2225.2 2225.6 2230.0 2233.3 2140.9 2171.2 2225.6 2231.9 2236.4 2199.2 2220.1 2227.9 2242.0 2247.3 2152.2 2154.0 2158.0 2173.8 2182.8 2140.5 2164.8 2187.6 2196.0 2201.8 8941.7 9092.0 9092.5 9092.5 9111.1 4974.6 5026.7 5063.6 5070.9 5094.3 3126.5 3236.3 3261.2 3278.6 3292.8 1037.9 1071.9 1075.7 1093.8 1117.6 11888.1 11890.6 11915.8 11942.2 12000.0 3970.2 4400.3 4407.1 4416.3 4426.2 10233.3 10236.9 10240.7 10255.1 10294.5 5077.9 5124.7 5127.3 5129.2 5136.8 4053.3 4658.4 4659.7 4672.0 4681.5 3832.8 3902.9 3950.4 3967.8 4015.1 1221.7 1224.8 1225.5 1228.7 1232.8 889.9 917.1 920.1 941.5 951.9 5797.0 5886.9 5893.4 5946.7 6286.8 890.5 941.8 955.9 971.6 973.4 3660.7 3998.5 4018.7 4073.2 4101.2 10857.6 11484.3 11521.5 11523.7 11527.8 11472.6 11487.0 11487.1 11487.9 11490.6 7350.2 7626.6 7939.5 7983.6 8033.6 5806.1 5922.7 5953.8 6000.6 6072.7 9649.1 9994.5 10047.3 10116.4 10143.5 10036.4 10141.7 10176.8 10270.6 10301.6 7693.0 7704.8 7843.9 7856.3 7933.0 8350.8 8394.0 8445.6 8447.9 8454.5 7302.9 7538.4 7630.9 7754.0 7947.5 7461.3 7471.7 7516.8 7540.1 7630.8 6910.7 6996.7 7007.1 7020.5 7075.6 5082.4 5107.3 5113.4 5169.4 5364.7 5111.9 5160.0 5259.5 5297.8 5306.6 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#4] prototype.html Cycles:180 Average:4836.35 Median:5527.17 stddev:1454.19 (26.3%) stddev-sans-first:1418.23 10:19:26 INFO - PROCESS | 17047 | Values: 320.9 324.5 331.5 336.7 338.5 5477.7 5521.4 5532.9 5540.6 5543.8 5415.2 5418.5 5429.3 5432.5 5468.2 3990.2 4118.0 4147.2 4197.9 4237.4 4249.4 4256.1 4262.8 4278.9 4305.5 4200.5 4234.4 4254.3 4271.4 4280.5 4013.3 4182.5 4196.4 4253.0 4257.3 3689.2 3694.2 3705.5 3712.7 3713.6 5365.7 5369.3 5376.5 5431.5 5451.4 4547.2 4770.0 4792.4 4832.1 4849.3 5666.9 5675.5 5676.3 5762.3 5795.9 4018.5 4027.6 4030.7 4034.1 4045.2 5896.5 5897.4 5928.7 5963.8 6001.8 4075.2 4107.8 4109.9 4122.3 4132.9 4174.9 4178.4 4178.8 4187.2 4212.6 4669.0 4769.0 4807.7 4815.8 4842.8 5752.5 5771.3 5772.8 5810.4 5818.0 1430.3 1440.5 1446.6 1449.6 1451.5 893.8 906.5 921.3 924.4 927.4 5448.3 5453.6 5486.8 5501.3 5547.2 5840.3 5841.5 5865.5 5921.6 5932.8 5405.7 5430.8 5446.6 5451.9 5608.8 3051.9 3103.2 3108.8 3131.4 3148.6 5754.9 6008.9 6037.8 6064.4 6069.5 6011.9 6046.2 6085.0 6092.7 6101.6 6111.7 6118.7 6118.7 6119.4 6148.5 5617.5 5885.1 5943.7 5957.8 5998.8 5869.5 5918.4 5936.9 5944.9 5973.0 5847.0 6139.4 6179.5 6217.5 6223.2 4130.5 4136.0 4139.9 4173.9 4174.4 6035.0 6036.7 6052.0 6054.6 6062.7 5685.6 5838.9 5859.6 5881.9 5974.5 5813.9 5837.3 5852.7 5864.8 5886.6 5412.9 5760.2 5771.7 5800.5 5829.0 5779.5 5826.0 5845.0 5854.6 5880.7 5699.0 5713.8 5718.8 5723.9 5725.7 10:19:26 INFO - PROCESS | 17047 | 10:19:26 INFO - PROCESS | 17047 | [#5] yui.html Cycles:180 Average:20948.54 Median:26482.87 stddev:31004.62 (117.1%) stddev-sans-first:31054.35 10:19:26 INFO - PROCESS | 17047 | Values: 708.6 717.4 758.4 777.5 821.7 15513.7 16722.2 16753.9 16761.2 16789.8 15979.8 16095.5 16111.7 16183.0 16254.3 747.6 770.6 771.2 776.3 796.3 790.4 792.3 796.8 798.5 800.0 824.2 828.3 829.0 830.1 832.1 813.2 814.2 814.7 817.7 821.1 600.3 600.8 601.4 603.1 603.4 15067.3 15075.8 15120.6 15200.2 15219.2 14331.7 14442.5 14461.5 14463.5 14566.9 11744.9 11814.8 11869.9 11880.0 12718.2 3758.5 3789.5 3849.4 3864.9 3998.5 78390.2 78885.0 79179.2 79823.6 80700.0 10806.9 11238.2 11280.8 11394.1 11533.0 21396.3 21401.1 21428.7 21574.9 21606.9 7973.3 8053.0 8193.1 8317.0 8520.6 4584.7 4858.9 4883.7 4977.0 5254.1 3503.0 3593.9 3646.8 3664.8 3671.3 585.1 605.7 612.6 622.6 630.8 642.7 656.1 666.8 675.2 678.3 9421.4 9497.8 9510.1 9878.8 10243.8 647.4 670.9 678.8 681.8 715.4 4332.4 4557.3 4837.0 5045.1 5073.4 119178.0 119635.4 122872.8 124977.4 128355.0 70615.0 105945.0 107667.0 109262.5 109513.5 74777.0 88854.6 90940.5 91562.5 92343.5 8910.3 9282.6 9312.5 9510.0 9638.6 44757.8 47378.8 48128.8 50318.0 52072.7 65542.3 72476.6 73007.6 73362.3 77367.6 10543.9 10811.8 10853.6 11138.8 11217.4 12988.4 13378.3 13665.7 13934.3 14117.5 13142.9 13329.3 14057.5 14083.1 14109.8 12665.3 12816.9 13011.5 14192.6 14199.7 12510.5 13044.9 13083.7 13205.1 13211.9 9922.3 9948.9 9977.0 10168.1 10239.9 9252.9 9640.7 10165.9 10335.9 10442.6 10:19:26 INFO - PROCESS | 17047 | -------- Summary: end -------- 10:19:26 INFO - PROCESS | 17047 | 10:19:27 INFO - TEST-INFO | 17047: exit 0 10:19:27 INFO - TEST-OK | dromaeo_css | took 1115675ms 10:19:27 INFO - TEST-START | kraken 10:19:27 INFO - operating with platform_type : linux_ 10:19:27 INFO - Initialising browser for kraken test... 10:19:27 INFO - TEST-INFO | started process 17411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptUPr3H/profile http://localhost:46046/getInfo.html) 10:19:32 INFO - PROCESS | 17411 | __metrics Screen width/height:1600/1200 10:19:32 INFO - PROCESS | 17411 | colorDepth:24 10:19:32 INFO - PROCESS | 17411 | Browser inner width/height: 1024/697 10:19:32 INFO - PROCESS | 17411 | __metrics 10:19:32 ERROR - PROCESS | 17411 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 10:19:33 INFO - TEST-INFO | 17411: exit 0 10:19:33 INFO - Browser initialized. 10:19:33 INFO - Running cycle 1/1 for kraken test... 10:19:33 INFO - TEST-INFO | started process 17537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptUPr3H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:46 INFO - PROCESS | 17537 | RSS: Main: 182894592 10:19:46 INFO - PROCESS | 17537 | 10:19:48 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46046/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:49 INFO - PROCESS | 17537 | RSS: Main: 196829184 10:19:49 INFO - PROCESS | 17537 | 10:19:52 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46046/tests/kraken/driver.html?testName=audio-dft) 10:19:52 INFO - PROCESS | 17537 | RSS: Main: 194592768 10:19:52 INFO - PROCESS | 17537 | 10:19:55 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46046/tests/kraken/driver.html?testName=audio-fft) 10:19:56 INFO - PROCESS | 17537 | RSS: Main: 191127552 10:19:56 INFO - PROCESS | 17537 | 10:19:58 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46046/tests/kraken/driver.html?testName=audio-oscillator) 10:19:59 INFO - PROCESS | 17537 | RSS: Main: 191717376 10:19:59 INFO - PROCESS | 17537 | 10:20:01 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:20:01 INFO - PROCESS | 17537 | RSS: Main: 191971328 10:20:01 INFO - PROCESS | 17537 | 10:20:05 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46046/tests/kraken/driver.html?testName=imaging-darkroom) 10:20:05 INFO - PROCESS | 17537 | RSS: Main: 192249856 10:20:05 INFO - PROCESS | 17537 | 10:20:09 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46046/tests/kraken/driver.html?testName=imaging-desaturate) 10:20:09 INFO - PROCESS | 17537 | RSS: Main: 190230528 10:20:09 INFO - PROCESS | 17537 | 10:20:12 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46046/tests/kraken/driver.html?testName=json-parse-financial) 10:20:13 INFO - PROCESS | 17537 | RSS: Main: 191164416 10:20:13 INFO - PROCESS | 17537 | 10:20:14 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:20:15 INFO - PROCESS | 17537 | RSS: Main: 191422464 10:20:15 INFO - PROCESS | 17537 | 10:20:17 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:20:17 INFO - PROCESS | 17537 | RSS: Main: 191275008 10:20:17 INFO - PROCESS | 17537 | 10:20:19 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:20:20 INFO - PROCESS | 17537 | RSS: Main: 191328256 10:20:20 INFO - PROCESS | 17537 | 10:20:23 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:20:24 INFO - PROCESS | 17537 | RSS: Main: 191791104 10:20:24 INFO - PROCESS | 17537 | 10:20:26 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:27 INFO - PROCESS | 17537 | RSS: Main: 192090112 10:20:27 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | Cycle 1(1): loaded http://localhost:46046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46046/tests/kraken/driver.html?testName=ai-astar) 10:20:29 INFO - PROCESS | 17537 | RSS: Main: 193761280 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | __start_tp_report 10:20:29 INFO - PROCESS | 17537 | _x_x_mozilla_page_load 10:20:29 INFO - PROCESS | 17537 | _x_x_mozilla_page_load_details 10:20:29 INFO - PROCESS | 17537 | |i|pagename|runs| 10:20:29 INFO - PROCESS | 17537 | |0;ai-astar;104;111;113;112;113;112;113;113;115;114 10:20:29 INFO - PROCESS | 17537 | |1;audio-beat-detection;154;127;124;167;125;126;127;132;156;124 10:20:29 INFO - PROCESS | 17537 | |2;audio-dft;163;163;164;164;168;164;161;161;162;163 10:20:29 INFO - PROCESS | 17537 | |3;audio-fft;79;86;80;114;76;76;77;76;96;77 10:20:29 INFO - PROCESS | 17537 | |4;audio-oscillator;82;84;116;84;83;83;100;83;83;113 10:20:29 INFO - PROCESS | 17537 | |5;imaging-gaussian-blur;119;118;118;117;118;119;117;118;118;118 10:20:29 INFO - PROCESS | 17537 | |6;imaging-darkroom;150;148;148;148;147;147;148;146;149;147 10:20:29 INFO - PROCESS | 17537 | |7;imaging-desaturate;87;85;85;85;85;85;85;85;85;85 10:20:29 INFO - PROCESS | 17537 | |8;json-parse-financial;55;54;53;55;55;55;57;60;54;54 10:20:29 INFO - PROCESS | 17537 | |9;json-stringify-tinderbox;60;60;60;61;60;59;60;60;59;60 10:20:29 INFO - PROCESS | 17537 | |10;stanford-crypto-aes;85;82;84;82;83;81;87;82;82;86 10:20:29 INFO - PROCESS | 17537 | |11;stanford-crypto-ccm;142;139;135;149;143;139;142;136;172;143 10:20:29 INFO - PROCESS | 17537 | |12;stanford-crypto-pbkdf2;167;168;166;166;167;168;168;173;168;172 10:20:29 INFO - PROCESS | 17537 | |13;stanford-crypto-sha256-iterative;73;68;73;66;68;66;66;72;67;66 10:20:29 INFO - PROCESS | 17537 | __end_tp_report 10:20:29 INFO - PROCESS | 17537 | __start_cc_report 10:20:29 INFO - PROCESS | 17537 | _x_x_mozilla_cycle_collect,791 10:20:29 INFO - PROCESS | 17537 | __end_cc_report 10:20:29 INFO - PROCESS | 17537 | __startTimestamp1477070429455__endTimestamp 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | ------- Summary: start ------- 10:20:29 INFO - PROCESS | 17537 | Number of tests: 14 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 10:20:29 INFO - PROCESS | 17537 | Values: 104.0 111.0 113.0 112.0 113.0 112.0 113.0 113.0 115.0 114.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.50 stddev:16.23 (12.5%) stddev-sans-first:15.89 10:20:29 INFO - PROCESS | 17537 | Values: 154.0 127.0 124.0 167.0 125.0 126.0 127.0 132.0 156.0 124.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 10:20:29 INFO - PROCESS | 17537 | Values: 163.0 163.0 164.0 164.0 168.0 164.0 161.0 161.0 162.0 163.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#3] audio-fft Cycles:10 Average:83.70 Median:78.00 stddev:12.37 (15.9%) stddev-sans-first:13.01 10:20:29 INFO - PROCESS | 17537 | Values: 79.0 86.0 80.0 114.0 76.0 76.0 77.0 76.0 96.0 77.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:83.00 stddev:13.44 (16.2%) stddev-sans-first:13.84 10:20:29 INFO - PROCESS | 17537 | Values: 82.0 84.0 116.0 84.0 83.0 83.0 100.0 83.0 83.0 113.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 10:20:29 INFO - PROCESS | 17537 | Values: 119.0 118.0 118.0 117.0 118.0 119.0 117.0 118.0 118.0 118.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:0.88 10:20:29 INFO - PROCESS | 17537 | Values: 150.0 148.0 148.0 148.0 147.0 147.0 148.0 146.0 149.0 147.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.00 10:20:29 INFO - PROCESS | 17537 | Values: 87.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 85.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.99 (3.6%) stddev-sans-first:2.11 10:20:29 INFO - PROCESS | 17537 | Values: 55.0 54.0 53.0 55.0 55.0 55.0 57.0 60.0 54.0 54.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 10:20:29 INFO - PROCESS | 17537 | Values: 60.0 60.0 60.0 61.0 60.0 59.0 60.0 60.0 59.0 60.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:2.01 (2.4%) stddev-sans-first:2.05 10:20:29 INFO - PROCESS | 17537 | Values: 85.0 82.0 84.0 82.0 83.0 81.0 87.0 82.0 82.0 86.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:142.50 stddev:10.61 (7.4%) stddev-sans-first:11.23 10:20:29 INFO - PROCESS | 17537 | Values: 142.0 139.0 135.0 149.0 143.0 139.0 142.0 136.0 172.0 143.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.00 stddev:2.36 (1.4%) stddev-sans-first:2.46 10:20:29 INFO - PROCESS | 17537 | Values: 167.0 168.0 166.0 166.0 167.0 168.0 168.0 173.0 168.0 172.0 10:20:29 INFO - PROCESS | 17537 | 10:20:29 INFO - PROCESS | 17537 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:2.99 (4.4%) stddev-sans-first:2.69 10:20:29 INFO - PROCESS | 17537 | Values: 73.0 68.0 73.0 66.0 68.0 66.0 66.0 72.0 67.0 66.0 10:20:29 INFO - PROCESS | 17537 | -------- Summary: end -------- 10:20:29 INFO - PROCESS | 17537 | 10:20:30 INFO - TEST-INFO | 17537: exit 0 10:20:30 INFO - TEST-OK | kraken | took 62756ms 10:20:30 INFO - SUITE-END | took 1178s 10:20:31 INFO - Completed test suite (00:19:38) 10:20:31 INFO - javascript benchmark 10:20:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7098.416457877592, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3038.9544156837637, 3099.7365223955967, 3105.130563442237, 3117.438861005018, 3142.324400253945, 5269.710165940881, 5293.232481290215, 5324.387695415024, 5393.352797664285, 5442.054689955549, 5304.098303288441, 5312.442193569668, 5368.1679339702405, 5424.0, 5433.429489903562, 4864.610831133518, 4898.338724272231, 4926.45808961014, 4945.7774400152075, 4956.801727930879, 4911.729854857981, 4988.950110498903, 5006.349174607296, 5014.2979982802435, 5051.343325367697, 4820.903581928377, 4875.878103047452, 4881.536254055859, 4924.852254432372, 4926.704397736129, 4887.975560122212, 4920.655554111214, 4943.728094954776, 4986.077575648516, 5001.949980500185, 4874.829380971649, 4894.535019173173, 4900.6569540132205, 4926.0394223126505, 4983.377077865267, 5281.234221037967, 5314.707691076989, 5354.919676204821, 5396.784128634889, 5407.783688652449, 5654.123610840326, 5755.597108202427, 5776.075827867521, 5790.131480277992, 5862.443067908542, 5774.422557744192, 5808.738606762706, 5813.331466881278, 5821.708914554255, 5825.388334224887, 5307.973460132752, 5374.247605335178, 5409.43200963901, 5415.675059496403, 5420.837374878721, 5789.623674461231, 5881.882362352814, 5915.290165180206, 5944.464998150187, 6011.48902343297, 5702.087665973424, 5708.372079071299, 5716.742746576414, 5721.799737009184, 5724.0, 5696.914546281809, 5774.133879918046, 5800.622959507703, 5805.187273781674, 5820.35976042635, 5610.49505544503, 5685.715714214272, 5707.0583353747, 5708.885822283531, 5715.2855893013375, 5755.3381361144, 5758.913616295759, 5761.251037365116, 5763.8559036024435, 5808.506276966421, 4320.481542214891, 4369.191699535596, 4371.388005679208, 4376.452943382077, 4426.601605855489, 3868.4777555030273, 3892.4355968384425, 3905.3751399776465, 3918.7060970427333, 3955.110100227426, 5519.3652729936575, 5549.916751248735, 5559.388467268597, 5596.832095037155, 5618.213450116987, 5794.652320860761, 5847.386024467455, 5852.326982396994, 5868.823935281948, 5872.941270587325, 5256.0, 5406.702631355234, 5433.565314774809, 5472.534834539029, 5540.473655002768, 4786.617070634341, 4787.114383839001, 4816.903661926742, 4834.927476087792, 4838.274258861199, 5848.152017957373, 5849.473547380756, 5863.941360586425, 5864.501517371071, 5905.675187864708, 5638.182463542681, 5739.110437882135, 5754.3382511010095, 5781.768729250783, 5789.421057894177, 5841.678707671119, 5928.525717942641, 5974.462298393166, 5992.820215393545, 6052.606580572248, 5687.829365119053, 5721.399253078534, 5738.167965644875, 5742.0, 5746.367899530965, 5779.884402312015, 5806.738696758572, 5826.329972053268, 5837.503812176013, 5850.0, 5537.667739935617, 5594.496495315441, 5600.963821692837, 5644.3508996465935, 5664.405237450009, 5518.089515229942, 5615.157726341082, 5620.213170156263, 5621.381648018633, 5631.183478395527, 5555.166724991283, 5568.693721845176, 5579.972100139636, 5582.49757521825, 5601.747921343631, 5664.235328230636, 5738.799142030176, 5743.74153163117, 5750.654960702204, 5793.333766616893, 5597.076482380362, 5614.719264036864, 5615.129654903497, 5615.157726341082, 5617.129344951539], "value": 5315.993078843521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.3232437237501, 588.5879884081145, 593.6705128653598, 600.3216365506977, 601.4586871815366, 40838.18323633526, 42508.78745606272, 42666.14667706644, 45495.317570236475, 45623.77188114063, 42376.0, 42397.57602423975, 42695.78652106743, 42724.14551708972, 43041.56958430415, 8672.262857657091, 8736.257418119467, 8747.737567872973, 8807.603657835412, 8812.779680507974, 8569.871451928226, 8574.78563035926, 8666.176713212235, 8708.129187081273, 8714.389992700513, 8619.1811777881, 8694.304455643532, 8694.434861733967, 8699.086595907433, 8740.562971851383, 8598.140185981352, 8619.95690021549, 8625.051244363114, 8657.0, 8714.259287960562, 8494.320454363637, 8556.914430855673, 8562.700305489278, 8578.871316930252, 8617.267532259766, 39780.20439591221, 40136.799316003526, 40198.79900600507, 40207.0, 40308.39537406941, 3324.501324801275, 3355.4966754986704, 3467.0638927489435, 3545.62770909056, 3729.5710993235853, 29216.269593260127, 29951.700482995107, 30134.0, 30198.69801301981, 30253.394932101455, 4153.54311025787, 4222.5566315536735, 4275.498907937669, 4397.719848588361, 4481.417415735966, 211821.0, 212644.0, 212797.0, 214490.0, 215274.99999999843, 53803.0, 53822.46485492034, 54424.18363724547, 54455.18317225245, 54456.45543544514, 57041.0, 57185.42814571884, 57395.0, 57453.71273143608, 57540.71229643909, 13605.523806666719, 13672.726545469035, 13756.0, 13759.96800239986, 13860.653483662989, 10866.945665271782, 10884.673459796219, 10910.072643825206, 10925.781484370427, 10950.288231264942, 12681.429335679917, 16171.919140404223, 16178.19109044543, 16240.350385984664, 16460.341586336654, 3045.786794924334, 3113.501839705636, 5568.220449137124, 5759.1937128802, 5793.159991801165, 892.7500299916034, 964.2912459342377, 1000.8798944126606, 1018.9490525473697, 1112.8386383974278, 30521.542176867366, 30546.516437352806, 30656.62045207971, 31069.844650776602, 31353.686463135076, 1079.3955384984276, 1085.2457542008228, 1123.4944275076248, 1135.2677522997785, 1139.4075080957855, 15909.306754507448, 15935.442259520862, 16381.344746210018, 16430.26359192749, 16805.747913781302, 498690.0, 502414.0, 503392.0, 506336.619802813, 507137.0, 55119.72440137774, 55525.16712249319, 55618.44381556214, 55801.44198558044, 55804.44195558074, 1272.1540175783, 1301.2127662763892, 1316.960491185266, 1319.4128612767227, 1319.4194554396227, 29328.41343173167, 30095.0, 30757.23106922345, 30889.0, 31290.687093129687, 49116.0, 49302.75348623234, 49601.0, 49665.50334496753, 49729.50270497249, 405918.0, 409529.0, 409915.0, 412029.0, 412470.0, 24768.380790480383, 24972.37569060788, 25005.0, 25039.499210015332, 25306.481611103394, 44802.3279650799, 45160.0, 45347.77326113348, 46049.30926036045, 46962.29556556586, 37495.43756843595, 38914.0, 39131.41302880516, 39712.80143599264, 41328.79335603303, 35951.64048359483, 38378.89160961516, 38698.80650596729, 39484.40773388344, 40619.59380406158, 39821.60178398179, 40148.1970360597, 40696.593034070465, 40814.79592602018, 40898.182036358514, 33370.66629333773, 35332.24476791636, 35930.4610430849, 36510.63489365178, 36714.26571468609, 27010.594841077007, 27064.729352707007, 27379.178624641292, 27540.862295689196, 27543.86228068927], "value": 18686.10007860394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.09638644355226, 369.46427679864195, 371.2704535587571, 381.7325088971511, 390.5918315360448, 17901.731474027885, 18654.813451865477, 18740.90629546852, 19392.51518712033, 19575.902120489412, 18099.28510723392, 18232.361867334646, 18953.147108380123, 18954.431367058976, 19160.80839191611, 5097.388313402387, 5174.80979374744, 5292.92060619091, 5300.840974770763, 5309.097453432906, 4261.829526818923, 5264.42091369949, 5303.946960530384, 5304.045271851065, 5306.124489459254, 5284.445133260991, 5289.233061206123, 5299.814506492274, 5306.7346632668405, 5311.1502159654465, 5382.757775900094, 5628.662280263197, 5682.232898558725, 5733.397993210736, 5737.454941780524, 5334.599905007101, 5352.705601191933, 5550.27846379972, 5555.194496797942, 5564.972175139139, 11795.0, 11822.349770762605, 11935.104867135, 11950.701232469259, 11951.760964780742, 2161.8162456191244, 2231.274835678395, 2248.303026061926, 2289.8511596746325, 2361.8700971446565, 9609.759756006086, 9920.156786673142, 10476.58093676252, 10582.153427725763, 11693.415329233589, 1911.9044047797554, 1924.769027716683, 1953.7850836407983, 1971.960560788776, 1989.1645508886302, 76723.6163819183, 80717.59641201815, 81649.59175204145, 82778.58610706907, 83853.0, 10287.0, 10376.844347334796, 10609.734756631146, 10669.253152279265, 10879.401632910107, 14823.332950017275, 14860.851391486163, 14870.70258594822, 14876.256187190596, 14922.0, 6999.545029573062, 7323.084614423197, 7368.4842061055215, 7473.738419155304, 7601.885971710429, 6963.408110310579, 6991.335823096798, 7102.325279098477, 7127.358537731526, 7222.205557388683, 4460.1525710114975, 4470.508244093147, 4528.818847246073, 4661.114388266218, 4707.7881495332795, 1884.1615481110773, 1977.3870100268962, 1998.810113039259, 2027.0, 2031.2687432524278, 891.8171774786153, 1004.2869562610629, 1051.9053285204368, 1053.0, 1057.6192570674705, 18388.540286492946, 18440.0, 18647.627047458976, 18688.68769276678, 19297.324593639154, 941.4398432932394, 951.2770294576034, 952.5903861339552, 986.6877053518803, 988.2588058955783, 10034.949825250973, 10602.628907988337, 10665.573377064986, 10700.090492308242, 10776.0, 457428.0, 463433.0, 463763.0, 466092.0, 466226.0, 50386.0, 86545.5672721645, 88368.0, 88631.55684221537, 89940.10059899317, 939.6241503398559, 953.0088707744007, 969.3214749675255, 993.7118235711707, 999.7900440907491, 16074.839251607335, 16213.432529861399, 16327.0, 16656.666866662843, 16821.990680559207, 38124.0, 38901.22197555976, 39978.0, 40138.598614013485, 41050.1789964205, 54586.45413545814, 55273.72363138159, 56143.71928140333, 56823.0, 58611.0, 7979.880301795361, 8156.632951517077, 8269.586520673822, 8441.451305665112, 8529.14708529142, 9382.95308523453, 12353.197042192589, 12712.491500340253, 12935.0, 13286.402111905181, 10990.780184396428, 11284.774304514029, 11358.602448914578, 11365.943170284427, 11874.168808183344, 11341.829872552084, 11395.430228488709, 11443.370614616277, 11512.769744605228, 11655.358955257543, 11190.664280071285, 11224.494897729784, 11373.260738052, 11413.771724565628, 11549.711257218636, 8183.918160818554, 8311.584420778816, 8334.291585215324, 8430.199131082538, 8579.571021449028, 9485.810283794424, 11346.205765596329, 11438.71403214893, 11482.0, 11979.507684618267], "value": 8704.52105626335, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.7537118689825, 1464.941402343906, 1574.7086788944046, 1691.2304901269924, 1736.3835838277403, 7790.259925307087, 8021.879671804913, 8484.703035393763, 9147.359684822057, 9154.130357616032, 8413.831723365543, 8709.520976346314, 8723.825523489526, 8879.911200888006, 8922.92924849019, 2165.4261620670536, 2225.2322948582796, 2225.643896976484, 2230.0, 2233.3076746208644, 2140.9250676226334, 2171.185805323004, 2225.5660146271484, 2231.8995645195923, 2236.4408897775556, 2199.164317559333, 2220.0897631970897, 2227.866328020316, 2242.0, 2247.269637367862, 2152.2467136502255, 2154.0306861912204, 2157.9892100539396, 2173.7500187478404, 2182.770809065049, 2140.518383363746, 2164.8376371772024, 2187.595294870438, 2196.000819627066, 2201.8458707890454, 8941.687040953535, 9092.0, 9092.545372731336, 9092.545372731403, 9111.088891110901, 4974.602031837444, 5026.698398096126, 5063.569596584295, 5070.898582028376, 5094.286799848024, 3126.546650735653, 3236.288016636336, 3261.2010057536054, 3278.639349671534, 3292.818894960776, 1037.8962103789636, 1071.8660167479065, 1075.6826736112866, 1093.775775965925, 1117.5585643670786, 11888.108391870644, 11890.643280701594, 11915.82126268098, 11942.223755455867, 12000.039996800322, 3970.166265084307, 4400.339949007611, 4407.074514351958, 4416.271315232951, 4426.22541055314, 10233.283670143019, 10236.948815255875, 10240.743981400525, 10255.07704306601, 10294.485275736184, 5077.949220507821, 5124.666896651705, 5127.256547800623, 5129.1793313070475, 5136.794528218904, 4053.310937140693, 4658.3711198988385, 4659.743714095689, 4671.95328046722, 4681.461631912305, 3832.770033797981, 3902.921941561153, 3950.4469374287623, 3967.7619342838943, 4015.0765323975647, 1221.712897469094, 1224.797908345113, 1225.4607972492254, 1228.6989687526614, 1232.7596118756755, 889.9110088991049, 917.1378903830378, 920.1442658327819, 941.5010044676333, 951.8714973478492, 5797.0, 5886.8822623547285, 5893.410658934073, 5946.732397042144, 6286.779962701284, 890.5013192612029, 941.8493041113526, 955.8805149356331, 971.5579411367811, 973.3819024919086, 3660.743747937619, 3998.480197574355, 4018.7387819792207, 4073.165001174752, 4101.2207680540605, 10857.619983300547, 11484.253523520945, 11521.53913843437, 11523.654290371302, 11527.76944461106, 11472.598459053894, 11487.0, 11487.138464615187, 11487.885121148849, 11490.597829075943, 7350.154732205865, 7626.580538070349, 7939.483933544301, 7983.600819958979, 8033.638486268132, 5806.129080637769, 5922.674252916131, 5953.821385358447, 6000.609960352563, 6072.666003369857, 9649.083337082966, 9994.450305233282, 10047.296689231684, 10116.443595602312, 10143.543540540546, 10036.397816130764, 10141.695749127539, 10176.796464070825, 10270.6405275815, 10301.587936482456, 7693.0, 7704.807379815549, 7843.882341764764, 7856.332211762065, 7932.960335198287, 8350.791230219293, 8393.95803020981, 8445.577721114043, 8447.859538962162, 8454.450460720034, 7302.890456643261, 7538.3969282458365, 7630.923690763243, 7753.961230194039, 7947.5231486111015, 7461.253874612496, 7471.738489152854, 7516.774496765106, 7540.057492813398, 7630.809229769078, 6910.654467276516, 6996.650167491707, 7007.089078419773, 7020.508564400443, 7075.646217689198, 5082.390113186441, 5107.259447380184, 5113.437521872516, 5169.353830771153, 5364.731763411735, 5111.897762044812, 5159.974200128975, 5259.526642602184, 5297.788088476572, 5306.602004849575], "value": 4558.863697750204, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.87165133946417, 324.5245715027486, 331.4713032712823, 336.68856307915155, 338.4973314627779, 5477.726113694314, 5521.4478552144765, 5532.889342213153, 5540.612157149001, 5543.750531226095, 5415.187721841726, 5418.485243901833, 5429.294191755076, 5432.483914028161, 5468.234447177399, 3990.241854047736, 4118.0, 4147.191297696951, 4197.874063778091, 4237.364395340693, 4249.405083288342, 4256.127493863751, 4262.808173632194, 4278.893027674302, 4305.526392096866, 4200.51694055183, 4234.364845273203, 4254.319543780205, 4271.373105540086, 4280.507741609708, 4013.3377992631326, 4182.498100227962, 4196.433481479991, 4253.043599944014, 4257.318828987378, 3689.206820533598, 3694.224212915291, 3705.46223317323, 3712.6658600725796, 3713.554373475173, 5365.734241278194, 5369.335505993155, 5376.51611354976, 5431.51116399522, 5451.37309209442, 4547.18150732868, 4769.95230047702, 4792.400949881265, 4832.081904438181, 4849.272609108627, 5666.943330566683, 5675.5459563234845, 5676.33212390176, 5762.3373312069225, 5795.913061304083, 4018.477597912282, 4027.556968733437, 4030.717849750519, 4034.09232922593, 4045.1505183911413, 5896.525868532867, 5897.380775018604, 5928.7332070056955, 5963.79552415546, 6001.789937352171, 4075.2053349597136, 4107.753534787863, 4109.8972525687095, 4122.299209134394, 4132.896677583084, 4174.874753757392, 4178.370435530146, 4178.8328466860985, 4187.225363307798, 4212.557681443465, 4669.0, 4768.9523104769205, 4807.711537307773, 4815.759212039454, 4842.806287748451, 5752.511036561856, 5771.278590176228, 5772.797952071657, 5810.448007439287, 5817.970910145422, 1430.3491911180388, 1440.4958264607512, 1446.6473846953133, 1449.6086056764825, 1451.520998070634, 893.848045832197, 906.51501446727, 921.3090182363228, 924.4176169013479, 927.3879239701764, 5448.291722076105, 5453.590980676465, 5486.780528778884, 5501.257330260443, 5547.223388725582, 5840.2991641003355, 5841.503472204825, 5865.530757539386, 5921.555883308769, 5932.79235226765, 5405.675659460445, 5430.778074933188, 5446.564274858002, 5451.945480545223, 5608.775648974077, 3051.862666180027, 3103.177657920653, 3108.7668424867775, 3131.373725254958, 3148.622165340174, 5754.942450575524, 6008.879822403527, 6037.78867739627, 6064.3935606439, 6069.544784141207, 6011.909821352596, 6046.244219472566, 6085.04472093143, 6092.72582733778, 6101.633901965896, 6111.724972376253, 6118.674903536627, 6118.724657390429, 6119.449249567471, 6148.508119350441, 5617.483279514427, 5885.058390657474, 5943.7028148591535, 5957.791477298274, 5998.780451233071, 5869.53043756507, 5918.408159184047, 5936.851578710567, 5944.910826337522, 5972.970135149297, 5847.0, 6139.373066137567, 6179.5056395489155, 6217.533684973736, 6223.222097237845, 4130.504339479162, 4135.97932010338, 4139.875803725893, 4173.895652608588, 4174.415581818608, 6034.969825150846, 6036.6679832609625, 6052.0, 6054.636721796706, 6062.666213433037, 5685.573581981285, 5838.912416313844, 5859.56053296013, 5881.882362352643, 5974.506373406648, 5813.912791308049, 5837.307180917486, 5852.707364631666, 5864.824055278348, 5886.558508111994, 5412.943081628956, 5760.164776107525, 5771.68255745938, 5800.462877337593, 5829.0, 5779.450952159538, 5826.0, 5844.970775146097, 5854.590178687451, 5880.676562789087, 5698.971505142447, 5713.800016999385, 5718.770464350185, 5723.914141287967, 5725.656460612377], "value": 4364.31237525444, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5996412027205, 717.4153065251819, 758.3705524414736, 777.4596655324548, 821.7288294862695, 15513.689726205483, 16722.163891805423, 16753.916230418832, 16761.1619419029, 16789.83210167901, 15979.840201597981, 16095.517134485955, 16111.677766444664, 16183.0, 16254.349826006975, 747.6112421540796, 770.6339488742858, 771.1594362145261, 776.3439893290189, 796.3151689546985, 790.4308897593723, 792.3304807437706, 796.77690246731, 798.4849771897123, 799.9680012799481, 824.2416976381713, 828.2628460670009, 829.0300348592132, 830.0744669693279, 832.0930186097153, 813.2314962360572, 814.226484839405, 814.7189219719187, 817.6851912013917, 821.0885916632533, 600.261678135891, 600.8377738010713, 601.362555690969, 603.1104121420913, 603.432773193197, 15067.321970511244, 15075.773863392058, 15120.621984450367, 15200.16399098049, 15219.239038048054, 14331.681189543617, 14442.470477583827, 14461.49384771528, 14463.493777717835, 14566.854331456656, 11744.94127529357, 11814.763704725943, 11869.94065029678, 11880.0, 12718.236905785683, 3758.5291417512453, 3789.5263092113487, 3849.441830934527, 3864.8647297344737, 3998.520177578709, 78390.21609783944, 78885.0, 79179.20820791833, 79823.60088199521, 80699.99999999942, 10806.891931080589, 11238.21332506733, 11280.830787538194, 11394.1454390921, 11533.0, 21396.251131210334, 21401.143954241656, 21428.678569821153, 21574.89212553927, 21606.89196554007, 7973.322267607203, 8053.0, 8193.139720329398, 8317.0, 8520.616572254263, 4584.6561507887045, 4858.902821943541, 4883.658143929891, 4977.038661996106, 5254.0805359062015, 3502.9649703502637, 3593.8562457501407, 3646.799426031541, 3664.780113193217, 3671.3391589514144, 585.1281590430314, 605.6910975402576, 612.5620181570199, 622.6170904893457, 630.8485963368759, 642.6658137768428, 656.0978654350268, 666.7632990288474, 675.166169780321, 678.3453966921944, 9421.38760980534, 9497.762555936157, 9510.1440870322, 9878.802423951482, 10243.795124097476, 647.4270270810273, 670.9496787740939, 678.803147087349, 681.8227260912099, 715.3954908102749, 4332.371806088163, 4557.270836666117, 4836.975815120973, 5045.142325804622, 5073.441921388644, 119178.0, 119635.40182299033, 122872.77127228792, 124977.37511312567, 128355.0, 70615.0, 105944.99999999846, 107667.0, 109262.45368773265, 109513.45243273892, 74777.0, 88854.55572722096, 90940.54529727309, 91562.54218728864, 92343.5382823095, 8910.331725120512, 9282.62869485213, 9312.534373281444, 9509.952450237704, 9638.614455421985, 44757.77621111873, 47378.76310618425, 48128.759356202994, 50318.0, 52072.73963630158, 65542.34457655363, 72476.63761681369, 73007.63496182485, 73362.26637733555, 77367.61316193383, 10543.894561054598, 10811.783764324828, 10853.620123295646, 11138.777224455303, 11217.383043932661, 12988.35058247065, 13378.331083445983, 13665.658358541115, 13934.30328483592, 14117.505887293895, 13142.868571314164, 13329.266890321125, 14057.507987220808, 14083.084599501, 14109.788353174505, 12665.303408312262, 12816.935915320364, 13011.544595939096, 14192.645183870485, 14199.716005679622, 12510.499580016698, 13044.934775326063, 13083.672908177372, 13205.141665791693, 13211.867881321448, 9922.305438619227, 9948.900510994798, 9977.0, 10168.135708464863, 10239.948800255952, 9252.861207082035, 9640.662576809778, 10165.949170254102, 10335.94832025835, 10442.63450779219], "value": 7435.454989707642, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 112.0, 113.0, 112.0, 113.0, 113.0, 115.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 124.0, 167.0, 125.0, 126.0, 127.0, 132.0, 156.0, 124.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 164.0, 168.0, 164.0, 161.0, 161.0, 162.0, 163.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 80.0, 114.0, 76.0, 76.0, 77.0, 76.0, 96.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 116.0, 84.0, 83.0, 83.0, 100.0, 83.0, 83.0, 113.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 146.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 55.0, 55.0, 57.0, 60.0, 54.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 59.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 84.0, 82.0, 83.0, 81.0, 87.0, 82.0, 82.0, 86.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 135.0, 149.0, 143.0, 139.0, 142.0, 136.0, 172.0, 143.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 166.0, 166.0, 167.0, 168.0, 168.0, 173.0, 168.0, 172.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 73.0, 66.0, 68.0, 66.0, 66.0, 72.0, 67.0, 66.0], "value": 68.5, "unit": "score"}]}]} 10:20:31 INFO - Return code: 0 10:20:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:31 ERROR - # TBPL SUCCESS # 10:20:31 INFO - Running post-action listener: _resource_record_post_action 10:20:31 INFO - [mozharness: 2016-10-21 17:20:31.277102Z] Finished run-tests step (success) 10:20:31 INFO - Running post-run listener: _resource_record_post_run 10:20:31 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404033536; Read time: 12; Write time: 266116 10:20:31 INFO - TinderboxPrint: CPU usage
13.4% 10:20:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:20:31 INFO - TinderboxPrint: I/O write bytes / time
404,033,536 / 266,116 10:20:31 INFO - TinderboxPrint: CPU idle
8,260.0 (86.6%) 10:20:31 INFO - TinderboxPrint: CPU user
1,215.3 (12.7%) 10:20:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:20:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115355648; Read time: 0; Write time: 81004 10:20:31 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288264192; Read time: 0; Write time: 185032 10:20:31 INFO - Running post-run listener: _upload_blobber_files 10:20:31 INFO - Blob upload gear active. 10:20:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:31 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 10:20:31 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'] 10:20:31 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 10:20:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:20:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:33 INFO - (blobuploader) - INFO - Done attempting. 10:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:36 INFO - (blobuploader) - INFO - Done attempting. 10:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:20:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:37 INFO - (blobuploader) - INFO - Done attempting. 10:20:37 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:37 INFO - Return code: 0 10:20:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5aa9a5fa091a5f9405b23b803dd2dafb86f4c2f7112e42e4ebd681916440c48a90c012d82deff8602dd670b5805cdb745a51aea11cce5472af91b24549e636d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d3b366ec92ad75ea628dd2be4b417d5f66fc57708811f59f196bd1dddf916815e4177ef96aace4ccd56a46d2d8323dd7244fe9ec7d1a5769ab2bbb7643bc0f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e3a6f45da6b5f6a3636321e744ca21936051f5eb334e4a51e9fc6a7b59508d3cc85c4d14a8d8065dc9c548b66b0b43a6fe0f183018d8cfa5a33fd91fc60a193"} 10:20:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:37 INFO - Contents: 10:20:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5aa9a5fa091a5f9405b23b803dd2dafb86f4c2f7112e42e4ebd681916440c48a90c012d82deff8602dd670b5805cdb745a51aea11cce5472af91b24549e636d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d3b366ec92ad75ea628dd2be4b417d5f66fc57708811f59f196bd1dddf916815e4177ef96aace4ccd56a46d2d8323dd7244fe9ec7d1a5769ab2bbb7643bc0f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e3a6f45da6b5f6a3636321e744ca21936051f5eb334e4a51e9fc6a7b59508d3cc85c4d14a8d8065dc9c548b66b0b43a6fe0f183018d8cfa5a33fd91fc60a193"} 10:20:37 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:37 INFO - Copying logs to upload dir... 10:20:37 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.678812 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-21 10:20:36.712860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 10:20:36.716644) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5aa9a5fa091a5f9405b23b803dd2dafb86f4c2f7112e42e4ebd681916440c48a90c012d82deff8602dd670b5805cdb745a51aea11cce5472af91b24549e636d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d3b366ec92ad75ea628dd2be4b417d5f66fc57708811f59f196bd1dddf916815e4177ef96aace4ccd56a46d2d8323dd7244fe9ec7d1a5769ab2bbb7643bc0f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e3a6f45da6b5f6a3636321e744ca21936051f5eb334e4a51e9fc6a7b59508d3cc85c4d14a8d8065dc9c548b66b0b43a6fe0f183018d8cfa5a33fd91fc60a193"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477062667/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a5aa9a5fa091a5f9405b23b803dd2dafb86f4c2f7112e42e4ebd681916440c48a90c012d82deff8602dd670b5805cdb745a51aea11cce5472af91b24549e636d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d3b366ec92ad75ea628dd2be4b417d5f66fc57708811f59f196bd1dddf916815e4177ef96aace4ccd56a46d2d8323dd7244fe9ec7d1a5769ab2bbb7643bc0f00", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2e3a6f45da6b5f6a3636321e744ca21936051f5eb334e4a51e9fc6a7b59508d3cc85c4d14a8d8065dc9c548b66b0b43a6fe0f183018d8cfa5a33fd91fc60a193"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-21 10:20:36.742570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:20:36.743161) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1477069043.316160-656974232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-21 10:20:36.827324) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 10:20:36.827648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-21 10:20:36.827973) ========= ========= Total master_lag: 0.16 =========