builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1480456684.11 results: success (0) buildid: 20161129101109 builduid: aabd393d6dfe4ddf9e312fa961227ddc revision: b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.107584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.108220) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.108537) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.150693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.151043) ========= 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=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 13:58:04-- 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% 32.0M=0s 2016-11-29 13:58:04 (32.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158518 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.348813) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.349357) ========= 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=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.068994 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.430664) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:04.431250) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 --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 b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 --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=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 13:58:04,531 truncating revision to first 12 chars 2016-11-29 13:58:04,531 Setting DEBUG logging. 2016-11-29 13:58:04,531 attempt 1/10 2016-11-29 13:58:04,531 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b24e8ff760ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 13:58:04,838 unpacking tar archive at: mozilla-inbound-b24e8ff760ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.682605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:05.130641) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:05.131230) ========= script_repo_revision: b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:05.131910) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:05.132398) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 13:58:05.143689) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-29 13:58:05.144081) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:58:05 INFO - MultiFileLogger online at 20161129 13:58:05 in /builds/slave/test 13:58:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 13:58:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:58:05 INFO - {'append_to_log': False, 13:58:05 INFO - 'base_work_dir': '/builds/slave/test', 13:58:05 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:58:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:58:05 INFO - 'branch': 'Mozilla-Inbound', 13:58:05 INFO - 'buildbot_json_path': 'buildprops.json', 13:58:05 INFO - 'config_files': ('talos/linux_config.py',), 13:58:05 INFO - 'default_actions': ('clobber', 13:58:05 INFO - 'read-buildbot-config', 13:58:05 INFO - 'download-and-extract', 13:58:05 INFO - 'populate-webroot', 13:58:05 INFO - 'create-virtualenv', 13:58:05 INFO - 'install', 13:58:05 INFO - 'run-tests'), 13:58:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:58:05 INFO - 'download_minidump_stackwalk': True, 13:58:05 INFO - 'download_symbols': 'ondemand', 13:58:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:58:05 INFO - 'tooltool.py': '/tools/tooltool.py', 13:58:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:58:05 INFO - '/tools/misc-python/virtualenv.py')}, 13:58:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:58:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:58:05 INFO - 'installer_path': 'installer.exe', 13:58:05 INFO - 'log_level': 'info', 13:58:05 INFO - 'log_name': 'talos', 13:58:05 INFO - 'log_to_console': True, 13:58:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:58:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:58:05 INFO - 'opt_config_files': (), 13:58:05 INFO - 'pip_index': False, 13:58:05 INFO - 'sps_profile': False, 13:58:05 INFO - 'sps_profile_interval': 0, 13:58:05 INFO - 'suite': 'dromaeojs', 13:58:05 INFO - 'system_bits': '32', 13:58:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:58:05 INFO - 'title': 'talos-linux64-ix-009', 13:58:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:58:05 INFO - 'use_talos_json': True, 13:58:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:58:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:58:05 INFO - 'work_dir': 'build'} 13:58:05 INFO - [mozharness: 2016-11-29 21:58:05.435915Z] Running clobber step. 13:58:05 INFO - Running pre-action listener: _resource_record_pre_action 13:58:05 INFO - Running main action method: clobber 13:58:05 INFO - rmtree: /builds/slave/test/build 13:58:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:58:06 INFO - Running post-action listener: _resource_record_post_action 13:58:06 INFO - [mozharness: 2016-11-29 21:58:06.507554Z] Finished clobber step (success) 13:58:06 INFO - [mozharness: 2016-11-29 21:58:06.507652Z] Running read-buildbot-config step. 13:58:06 INFO - Running pre-action listener: _resource_record_pre_action 13:58:06 INFO - Running main action method: read_buildbot_config 13:58:06 INFO - Using buildbot properties: 13:58:06 INFO - { 13:58:06 INFO - "project": "", 13:58:06 INFO - "product": "firefox", 13:58:06 INFO - "script_repo_revision": "production", 13:58:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 13:58:06 INFO - "repository": "", 13:58:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 13:58:06 INFO - "buildid": "20161129101109", 13:58:06 INFO - "pgo_build": "True", 13:58:06 INFO - "basedir": "/builds/slave/test", 13:58:06 INFO - "buildnumber": 2184, 13:58:06 INFO - "slavename": "talos-linux64-ix-009", 13:58:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:58:06 INFO - "platform": "ubuntu64_hw", 13:58:06 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:58:06 INFO - "branch": "mozilla-inbound", 13:58:06 INFO - "repo_path": "integration/mozilla-inbound", 13:58:06 INFO - "revision": "b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19", 13:58:06 INFO - "stage_platform": "linux64-pgo", 13:58:06 INFO - "builduid": "aabd393d6dfe4ddf9e312fa961227ddc", 13:58:06 INFO - "slavebuilddir": "test" 13:58:06 INFO - } 13:58:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 13:58:06 INFO - Running post-action listener: _resource_record_post_action 13:58:06 INFO - [mozharness: 2016-11-29 21:58:06.510069Z] Finished read-buildbot-config step (success) 13:58:06 INFO - [mozharness: 2016-11-29 21:58:06.510155Z] Running download-and-extract step. 13:58:06 INFO - Running pre-action listener: _resource_record_pre_action 13:58:06 INFO - Running main action method: download_and_extract 13:58:06 INFO - mkdir: /builds/slave/test/build/tests 13:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:06 INFO - trying https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:58:06 INFO - Downloading https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:58:07 INFO - Downloaded 1361 bytes. 13:58:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:58:07 INFO - Using the following test package requirements: 13:58:07 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:58:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:58:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'jsshell-linux-x86_64.zip'], 13:58:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:58:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:58:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:58:07 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:58:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:58:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:58:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:58:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:58:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:58:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:58:07 INFO - Fetch https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:58:07 INFO - Http code: 200 13:58:07 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 13:58:07 INFO - x-amz-cf-id: qHWVNlOjOolBow7DxtLDxctNgxvmu65MXEqOAO1Mx_nOmq60DHN9yg== 13:58:07 INFO - x-amz-version-id: 9GYtPQgGSu1lIIFxDSrX02SWLNkRsFq0 13:58:07 INFO - Expected file size: 21782883 13:58:07 INFO - Obtained file size: 21782883 13:58:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:58:12 INFO - Http code: 200 13:58:12 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 13:58:12 INFO - x-amz-cf-id: BRRmex_6g8HCB8wEN8jLfV8Q78SmuyCCfmv7bJv2NLdibbCWtMbtag== 13:58:12 INFO - x-amz-version-id: 9GYtPQgGSu1lIIFxDSrX02SWLNkRsFq0 13:58:12 INFO - Expected file size: 21782883 13:58:12 INFO - Obtained file size: 21782883 13:58:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 13:58:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:58:17 INFO - Fetch https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:58:18 INFO - Http code: 200 13:58:18 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 13:58:18 INFO - x-amz-cf-id: voUBP19PNBeYk7T_XgQg_mYPVk-nNekpAgouHN2wHsJK-ImIau9AqA== 13:58:18 INFO - x-amz-version-id: WwN8cXf9bcpYFZNr1HRSbjUbbalYV6VJ 13:58:18 INFO - Expected file size: 14409702 13:58:18 INFO - Obtained file size: 14409702 13:58: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')]} 13:58:18 INFO - trying https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:58:18 INFO - Downloading https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:58:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:58:19 INFO - Downloaded 59740377 bytes. 13:58:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:58:19 INFO - mkdir: /builds/slave/test/properties 13:58:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:58:19 INFO - Writing to file /builds/slave/test/properties/build_url 13:58:19 INFO - Contents: 13:58:19 INFO - build_url:https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:58:20 INFO - Running post-action listener: _resource_record_post_action 13:58:20 INFO - Running post-action listener: set_extra_try_arguments 13:58:20 INFO - [mozharness: 2016-11-29 21:58:20.418313Z] Finished download-and-extract step (success) 13:58:20 INFO - [mozharness: 2016-11-29 21:58:20.418541Z] Running populate-webroot step. 13:58:20 INFO - Running pre-action listener: _resource_record_pre_action 13:58:20 INFO - Running main action method: populate_webroot 13:58:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:58:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:58:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:58:20 INFO - '--tppagecycles', 13:58:20 INFO - '7'], 13:58:20 INFO - 'tests': ['tsvgm']}}, 13:58:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:58:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:58:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:58:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:58:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:58:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['damp', 'tps']}, 13:58:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'tests': ['damp', 'tps']}, 13:58:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['dromaeo_dom']}, 13:58:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:58:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['basic_compositor_video']}, 13:58:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:58:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'other-e10s': {'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['a11yr', 13:58:20 INFO - 'ts_paint', 13:58:20 INFO - 'tpaint', 13:58:20 INFO - 'sessionrestore', 13:58:20 INFO - 'sessionrestore_no_auto_restore', 13:58:20 INFO - 'tabpaint']}, 13:58:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['tsvgx', 13:58:20 INFO - 'tsvgr_opacity', 13:58:20 INFO - 'tart', 13:58:20 INFO - 'tscrollx', 13:58:20 INFO - 'cart', 13:58:20 INFO - 'tsvg_static']}, 13:58:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:58:20 INFO - 'tsvgr_opacity', 13:58:20 INFO - 'tart', 13:58:20 INFO - 'tscrollx', 13:58:20 INFO - 'cart', 13:58:20 INFO - 'tsvg_static']}, 13:58:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'talos_options': ['--disable-e10s'], 13:58:20 INFO - 'tests': ['tp5o']}, 13:58:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:58:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'talos_options': ['--disable-e10s', 13:58:20 INFO - '--xperf_path', 13:58:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:20 INFO - 'tests': ['tp5n']}, 13:58:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:58:20 INFO - 'talos_options': ['--xperf_path', 13:58:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:58:20 INFO - 'tests': ['tp5n']}}, 13:58:20 INFO - 'talos.zip': {'path': '', 13:58:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:58:20 INFO - Running post-action listener: _resource_record_post_action 13:58:20 INFO - [mozharness: 2016-11-29 21:58:20.440536Z] Finished populate-webroot step (success) 13:58:20 INFO - [mozharness: 2016-11-29 21:58:20.440623Z] Running create-virtualenv step. 13:58:20 INFO - Running pre-action listener: _resource_record_pre_action 13:58:20 INFO - Running main action method: create_virtualenv 13:58:20 INFO - Creating virtualenv /builds/slave/test/build/venv 13:58:20 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 13:58:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:58:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:58:20 INFO - Using real prefix '/usr' 13:58:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:58:21 INFO - Installing distribute.............................................................................................................................................................................................done. 13:58:23 INFO - Installing pip.................done. 13:58:23 INFO - Return code: 0 13:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:58:23 INFO - Reading from file tmpfile_stdout 13:58:23 INFO - Output received: 13:58:23 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) 13:58:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:58: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')]} 13:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58: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', 'pip>=1.5'] in /builds/slave/test/build 13:58: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 pip>=1.5 13:58:23 INFO - Using env: {'DISPLAY': ':0', 13:58:23 INFO - 'HOME': '/home/cltbld', 13:58:23 INFO - 'LANG': 'en_US.UTF-8', 13:58:23 INFO - 'LANGUAGE': 'en_US:en', 13:58:23 INFO - 'LOGNAME': 'cltbld', 13:58:23 INFO - 'MAIL': '/var/mail/cltbld', 13:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:23 INFO - 'MOZ_NO_REMOTE': '1', 13:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:23 INFO - 'NO_EM_RESTART': '1', 13:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:23 INFO - 'PWD': '/builds/slave/test', 13:58:23 INFO - 'SHELL': '/bin/bash', 13:58:23 INFO - 'SHLVL': '1', 13:58:23 INFO - 'TERM': 'linux', 13:58:23 INFO - 'TMOUT': '86400', 13:58:23 INFO - 'USER': 'cltbld', 13:58:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:23 INFO - '_': '/tools/buildbot/bin/python'} 13:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:23 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 13:58:23 INFO - Cleaning up... 13:58:23 INFO - Return code: 0 13:58:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:58: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')]} 13:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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', '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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:58: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 psutil>=3.1.1 13:58:23 INFO - Using env: {'DISPLAY': ':0', 13:58:23 INFO - 'HOME': '/home/cltbld', 13:58:23 INFO - 'LANG': 'en_US.UTF-8', 13:58:23 INFO - 'LANGUAGE': 'en_US:en', 13:58:23 INFO - 'LOGNAME': 'cltbld', 13:58:23 INFO - 'MAIL': '/var/mail/cltbld', 13:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:23 INFO - 'MOZ_NO_REMOTE': '1', 13:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:23 INFO - 'NO_EM_RESTART': '1', 13:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:23 INFO - 'PWD': '/builds/slave/test', 13:58:23 INFO - 'SHELL': '/bin/bash', 13:58:23 INFO - 'SHLVL': '1', 13:58:23 INFO - 'TERM': 'linux', 13:58:23 INFO - 'TMOUT': '86400', 13:58:23 INFO - 'USER': 'cltbld', 13:58:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:23 INFO - '_': '/tools/buildbot/bin/python'} 13:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:23 INFO - Downloading/unpacking psutil>=3.1.1 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58: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 13:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:58:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:26 INFO - Installing collected packages: psutil 13:58:26 INFO - Running setup.py install for psutil 13:58:26 INFO - building 'psutil._psutil_linux' extension 13:58:26 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 13:58:27 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 13:58:27 INFO - building 'psutil._psutil_posix' extension 13:58:27 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 13:58:27 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 13:58:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:58:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:58:27 INFO - Successfully installed psutil 13:58:27 INFO - Cleaning up... 13:58:27 INFO - Return code: 0 13:58:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:58: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')]} 13:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58: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')]} 13:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:27 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:27 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 13:58:27 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 13:58:27 INFO - Using env: {'DISPLAY': ':0', 13:58:27 INFO - 'HOME': '/home/cltbld', 13:58:27 INFO - 'LANG': 'en_US.UTF-8', 13:58:27 INFO - 'LANGUAGE': 'en_US:en', 13:58:27 INFO - 'LOGNAME': 'cltbld', 13:58:27 INFO - 'MAIL': '/var/mail/cltbld', 13:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:27 INFO - 'MOZ_NO_REMOTE': '1', 13:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:27 INFO - 'NO_EM_RESTART': '1', 13:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:27 INFO - 'PWD': '/builds/slave/test', 13:58:27 INFO - 'SHELL': '/bin/bash', 13:58:27 INFO - 'SHLVL': '1', 13:58:27 INFO - 'TERM': 'linux', 13:58:27 INFO - 'TMOUT': '86400', 13:58:27 INFO - 'USER': 'cltbld', 13:58:27 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:27 INFO - '_': '/tools/buildbot/bin/python'} 13:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:27 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 13:58:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:58:29 INFO - Installing collected packages: mozsystemmonitor 13:58:29 INFO - Running setup.py install for mozsystemmonitor 13:58:29 INFO - Successfully installed mozsystemmonitor 13:58:29 INFO - Cleaning up... 13:58:29 INFO - Return code: 0 13:58:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:58:29 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')]} 13:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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')]} 13:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:29 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:29 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 13:58:29 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 13:58:29 INFO - Using env: {'DISPLAY': ':0', 13:58:29 INFO - 'HOME': '/home/cltbld', 13:58:29 INFO - 'LANG': 'en_US.UTF-8', 13:58:29 INFO - 'LANGUAGE': 'en_US:en', 13:58:29 INFO - 'LOGNAME': 'cltbld', 13:58:29 INFO - 'MAIL': '/var/mail/cltbld', 13:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:29 INFO - 'MOZ_NO_REMOTE': '1', 13:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:29 INFO - 'NO_EM_RESTART': '1', 13:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:29 INFO - 'PWD': '/builds/slave/test', 13:58:29 INFO - 'SHELL': '/bin/bash', 13:58:29 INFO - 'SHLVL': '1', 13:58:29 INFO - 'TERM': 'linux', 13:58:29 INFO - 'TMOUT': '86400', 13:58:29 INFO - 'USER': 'cltbld', 13:58:29 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:29 INFO - '_': '/tools/buildbot/bin/python'} 13:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:30 INFO - Downloading/unpacking jsonschema==2.5.1 13:58:30 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 13:58:30 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 13:58:30 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 13:58:30 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 13:58:30 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 13:58:30 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 13:58:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:58:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:58:32 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 13:58:32 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 13:58:32 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 13:58:32 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 13:58:32 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 13:58:32 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 13:58:32 INFO - Downloading functools32-3.2.3-2.tar.gz 13:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:58:32 INFO - warning: no files found matching '*.txt' 13:58:32 INFO - no previously-included directories found matching 'build' 13:58:32 INFO - no previously-included directories found matching 'dist' 13:58:32 INFO - no previously-included directories found matching '.git*' 13:58:32 INFO - Installing collected packages: jsonschema, functools32 13:58:32 INFO - Running setup.py install for functools32 13:58:32 INFO - warning: no files found matching '*.txt' 13:58:32 INFO - no previously-included directories found matching 'build' 13:58:32 INFO - no previously-included directories found matching 'dist' 13:58:32 INFO - no previously-included directories found matching '.git*' 13:58:32 INFO - Successfully installed jsonschema functools32 13:58:32 INFO - Cleaning up... 13:58:32 INFO - Return code: 0 13:58:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:32 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 13:58:32 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 13:58:32 INFO - Using env: {'DISPLAY': ':0', 13:58:32 INFO - 'HOME': '/home/cltbld', 13:58:32 INFO - 'LANG': 'en_US.UTF-8', 13:58:32 INFO - 'LANGUAGE': 'en_US:en', 13:58:32 INFO - 'LOGNAME': 'cltbld', 13:58:32 INFO - 'MAIL': '/var/mail/cltbld', 13:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:32 INFO - 'MOZ_NO_REMOTE': '1', 13:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:32 INFO - 'NO_EM_RESTART': '1', 13:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:32 INFO - 'PWD': '/builds/slave/test', 13:58:32 INFO - 'SHELL': '/bin/bash', 13:58:32 INFO - 'SHLVL': '1', 13:58:32 INFO - 'TERM': 'linux', 13:58:32 INFO - 'TMOUT': '86400', 13:58:32 INFO - 'USER': 'cltbld', 13:58:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:32 INFO - '_': '/tools/buildbot/bin/python'} 13:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:58:32 INFO - Cleaning up... 13:58:32 INFO - Return code: 0 13:58:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:32 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:32 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 13:58:32 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 13:58:32 INFO - Using env: {'DISPLAY': ':0', 13:58:32 INFO - 'HOME': '/home/cltbld', 13:58:32 INFO - 'LANG': 'en_US.UTF-8', 13:58:32 INFO - 'LANGUAGE': 'en_US:en', 13:58:32 INFO - 'LOGNAME': 'cltbld', 13:58:32 INFO - 'MAIL': '/var/mail/cltbld', 13:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:32 INFO - 'MOZ_NO_REMOTE': '1', 13:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:32 INFO - 'NO_EM_RESTART': '1', 13:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:32 INFO - 'PWD': '/builds/slave/test', 13:58:32 INFO - 'SHELL': '/bin/bash', 13:58:32 INFO - 'SHLVL': '1', 13:58:32 INFO - 'TERM': 'linux', 13:58:32 INFO - 'TMOUT': '86400', 13:58:32 INFO - 'USER': 'cltbld', 13:58:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:32 INFO - '_': '/tools/buildbot/bin/python'} 13:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:33 INFO - Downloading/unpacking blobuploader==1.2.4 13:58:33 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 13:58:33 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 13:58:33 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 13:58:33 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 13:58:33 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 13:58:33 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 13:58:34 INFO - Downloading blobuploader-1.2.4.tar.gz 13:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:58:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:58:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 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 13:58:35 INFO - Downloading docopt-0.6.1.tar.gz 13:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:58:35 INFO - Installing collected packages: blobuploader, requests, docopt 13:58:35 INFO - Running setup.py install for blobuploader 13:58:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:58:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:58:35 INFO - Running setup.py install for requests 13:58:36 INFO - Running setup.py install for docopt 13:58:36 INFO - Successfully installed blobuploader requests docopt 13:58:36 INFO - Cleaning up... 13:58:36 INFO - Return code: 0 13:58:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:36 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')]} 13:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:36 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')]} 13:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:36 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:36 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 13:58:36 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 13:58:36 INFO - Using env: {'DISPLAY': ':0', 13:58:36 INFO - 'HOME': '/home/cltbld', 13:58:36 INFO - 'LANG': 'en_US.UTF-8', 13:58:36 INFO - 'LANGUAGE': 'en_US:en', 13:58:36 INFO - 'LOGNAME': 'cltbld', 13:58:36 INFO - 'MAIL': '/var/mail/cltbld', 13:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:36 INFO - 'MOZ_NO_REMOTE': '1', 13:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:36 INFO - 'NO_EM_RESTART': '1', 13:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:36 INFO - 'PWD': '/builds/slave/test', 13:58:36 INFO - 'SHELL': '/bin/bash', 13:58:36 INFO - 'SHLVL': '1', 13:58:36 INFO - 'TERM': 'linux', 13:58:36 INFO - 'TMOUT': '86400', 13:58:36 INFO - 'USER': 'cltbld', 13:58:36 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:36 INFO - '_': '/tools/buildbot/bin/python'} 13:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:36 INFO - Running setup.py (path:/tmp/pip-GXl4kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:36 INFO - Running setup.py (path:/tmp/pip-vCJG2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:36 INFO - Running setup.py (path:/tmp/pip-lituMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:36 INFO - Running setup.py (path:/tmp/pip-k9fMUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:36 INFO - Running setup.py (path:/tmp/pip-3efNVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:36 INFO - Running setup.py (path:/tmp/pip-GZU211-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:37 INFO - Running setup.py (path:/tmp/pip-DBvp0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:37 INFO - Running setup.py (path:/tmp/pip-alx2O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:37 INFO - Running setup.py (path:/tmp/pip-L58lJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:37 INFO - Running setup.py (path:/tmp/pip-9mP3lf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:37 INFO - Running setup.py (path:/tmp/pip-lqKZOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:37 INFO - Running setup.py (path:/tmp/pip-vINTmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:37 INFO - Running setup.py (path:/tmp/pip-aGgJt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:37 INFO - Running setup.py (path:/tmp/pip-yZWRuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:37 INFO - Running setup.py (path:/tmp/pip-MOJEhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:37 INFO - Running setup.py (path:/tmp/pip-VFuSI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:37 INFO - Running setup.py (path:/tmp/pip-oKfpEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:58:37 INFO - Running setup.py install for manifestparser 13:58:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:58:37 INFO - Running setup.py install for mozcrash 13:58:38 INFO - Running setup.py install for mozdebug 13:58:38 INFO - Running setup.py install for mozdevice 13:58:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for mozfile 13:58:38 INFO - Running setup.py install for mozhttpd 13:58:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for mozinfo 13:58:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for mozInstall 13:58:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for mozleak 13:58:38 INFO - Running setup.py install for mozlog 13:58:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for moznetwork 13:58:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:58:38 INFO - Running setup.py install for mozprocess 13:58:39 INFO - Running setup.py install for mozprofile 13:58:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:58:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:58:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:58:39 INFO - Running setup.py install for mozrunner 13:58:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:58:39 INFO - Running setup.py install for mozscreenshot 13:58:39 INFO - Running setup.py install for moztest 13:58:39 INFO - Running setup.py install for mozversion 13:58:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:58:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:58:39 INFO - Cleaning up... 13:58:39 INFO - Return code: 0 13:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:39 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:39 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 13:58:39 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 13:58:39 INFO - Using env: {'DISPLAY': ':0', 13:58:39 INFO - 'HOME': '/home/cltbld', 13:58:39 INFO - 'LANG': 'en_US.UTF-8', 13:58:39 INFO - 'LANGUAGE': 'en_US:en', 13:58:39 INFO - 'LOGNAME': 'cltbld', 13:58:39 INFO - 'MAIL': '/var/mail/cltbld', 13:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:39 INFO - 'MOZ_NO_REMOTE': '1', 13:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:39 INFO - 'NO_EM_RESTART': '1', 13:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:39 INFO - 'PWD': '/builds/slave/test', 13:58:39 INFO - 'SHELL': '/bin/bash', 13:58:39 INFO - 'SHLVL': '1', 13:58:39 INFO - 'TERM': 'linux', 13:58:39 INFO - 'TMOUT': '86400', 13:58:39 INFO - 'USER': 'cltbld', 13:58:39 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:39 INFO - '_': '/tools/buildbot/bin/python'} 13:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:58:39 INFO - Running setup.py (path:/tmp/pip-oP_WDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:58:39 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)) 13:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:58:39 INFO - Running setup.py (path:/tmp/pip-8jFAyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:58:39 INFO - Running setup.py (path:/tmp/pip-W8t8G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:58:40 INFO - Running setup.py (path:/tmp/pip-VyX421-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:58:40 INFO - Running setup.py (path:/tmp/pip-AAnAzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:58:40 INFO - Running setup.py (path:/tmp/pip-5ZhhYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:58:40 INFO - Running setup.py (path:/tmp/pip-kOg4Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:58:40 INFO - Running setup.py (path:/tmp/pip-nXE_1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:58:40 INFO - Running setup.py (path:/tmp/pip-5jMiyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:58:40 INFO - Running setup.py (path:/tmp/pip-CmIcaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:58:40 INFO - Running setup.py (path:/tmp/pip-CkWSKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:58:40 INFO - Running setup.py (path:/tmp/pip-yrPHVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:58:40 INFO - Running setup.py (path:/tmp/pip-nO8Yv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:58:40 INFO - Running setup.py (path:/tmp/pip-hQeffS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:40 INFO - Running setup.py (path:/tmp/pip-dZBCos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:58:40 INFO - Running setup.py (path:/tmp/pip-5TXMAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:58:40 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)) 13:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:58:40 INFO - Running setup.py (path:/tmp/pip-xpRJHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:58:41 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)) 13:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:58:41 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)) 13:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:58:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:58:41 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 13:58:41 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 13:58:41 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 13:58:41 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 13:58:41 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 13:58:41 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 13:58:43 INFO - Downloading blessings-1.6.tar.gz 13:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:58:43 INFO - Installing collected packages: blessings 13:58:43 INFO - Running setup.py install for blessings 13:58:43 INFO - Successfully installed blessings 13:58:43 INFO - Cleaning up... 13:58:43 INFO - Return code: 0 13:58:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:58:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:43 INFO - Reading from file tmpfile_stdout 13:58:43 INFO - Current package versions: 13:58:43 INFO - argparse == 1.2.1 13:58:43 INFO - blessings == 1.6 13:58:43 INFO - blobuploader == 1.2.4 13:58:43 INFO - docopt == 0.6.1 13:58:43 INFO - functools32 == 3.2.3-2 13:58:43 INFO - jsonschema == 2.5.1 13:58:43 INFO - manifestparser == 1.1 13:58:43 INFO - mozInstall == 1.12 13:58:43 INFO - mozcrash == 1.0 13:58:43 INFO - mozdebug == 0.1 13:58:43 INFO - mozdevice == 0.49 13:58:43 INFO - mozfile == 1.2 13:58:43 INFO - mozhttpd == 0.7 13:58:43 INFO - mozinfo == 0.9 13:58:43 INFO - mozleak == 0.1 13:58:43 INFO - mozlog == 3.4 13:58:43 INFO - moznetwork == 0.27 13:58:43 INFO - mozprocess == 0.23 13:58:43 INFO - mozprofile == 0.28 13:58:43 INFO - mozrunner == 6.13 13:58:43 INFO - mozscreenshot == 0.1 13:58:43 INFO - mozsystemmonitor == 0.3 13:58:43 INFO - moztest == 0.7 13:58:43 INFO - mozversion == 1.4 13:58:43 INFO - psutil == 3.1.1 13:58:43 INFO - requests == 1.2.3 13:58:43 INFO - wsgiref == 0.1.2 13:58:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 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 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:43 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 13:58:43 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 13:58:43 INFO - Using env: {'DISPLAY': ':0', 13:58:43 INFO - 'HOME': '/home/cltbld', 13:58:43 INFO - 'LANG': 'en_US.UTF-8', 13:58:43 INFO - 'LANGUAGE': 'en_US:en', 13:58:43 INFO - 'LOGNAME': 'cltbld', 13:58:43 INFO - 'MAIL': '/var/mail/cltbld', 13:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:43 INFO - 'MOZ_NO_REMOTE': '1', 13:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:43 INFO - 'NO_EM_RESTART': '1', 13:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:43 INFO - 'PWD': '/builds/slave/test', 13:58:43 INFO - 'SHELL': '/bin/bash', 13:58:43 INFO - 'SHLVL': '1', 13:58:43 INFO - 'TERM': 'linux', 13:58:43 INFO - 'TMOUT': '86400', 13:58:43 INFO - 'USER': 'cltbld', 13:58:43 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:43 INFO - '_': '/tools/buildbot/bin/python'} 13:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 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)) 13:58:43 INFO - Cleaning up... 13:58:43 INFO - Return code: 0 13:58:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:58:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdceed78e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2892130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, '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': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', '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 13:58:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:58:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:58:43 INFO - Using env: {'DISPLAY': ':0', 13:58:43 INFO - 'HOME': '/home/cltbld', 13:58:43 INFO - 'LANG': 'en_US.UTF-8', 13:58:43 INFO - 'LANGUAGE': 'en_US:en', 13:58:43 INFO - 'LOGNAME': 'cltbld', 13:58:43 INFO - 'MAIL': '/var/mail/cltbld', 13:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:58:43 INFO - 'MOZ_NO_REMOTE': '1', 13:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:58:43 INFO - 'NO_EM_RESTART': '1', 13:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:58:43 INFO - 'PWD': '/builds/slave/test', 13:58:43 INFO - 'SHELL': '/bin/bash', 13:58:43 INFO - 'SHLVL': '1', 13:58:43 INFO - 'TERM': 'linux', 13:58:43 INFO - 'TMOUT': '86400', 13:58:43 INFO - 'USER': 'cltbld', 13:58:43 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:58:43 INFO - '_': '/tools/buildbot/bin/python'} 13:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:58:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:58:43 INFO - Cleaning up... 13:58:43 INFO - Return code: 0 13:58:43 INFO - Running post-action listener: _resource_record_post_action 13:58:43 INFO - Running post-action listener: _start_resource_monitoring 13:58:44 INFO - Starting resource monitoring. 13:58:44 INFO - [mozharness: 2016-11-29 21:58:44.030702Z] Finished create-virtualenv step (success) 13:58:44 INFO - [mozharness: 2016-11-29 21:58:44.031645Z] Running install step. 13:58:44 INFO - Running pre-action listener: _resource_record_pre_action 13:58:44 INFO - Running main action method: install 13:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:58:44 INFO - Reading from file tmpfile_stdout 13:58:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:58:44 INFO - Reading from file tmpfile_stdout 13:58:44 INFO - Output received: 13:58:44 INFO - Usage: mozinstall [options] installer 13:58:44 INFO - Options: 13:58:44 INFO - -h, --help show this help message and exit 13:58:44 INFO - -d DEST, --destination=DEST 13:58:44 INFO - Directory to install application into. [default: 13:58:44 INFO - "/builds/slave/test"] 13:58:44 INFO - --app=APP Application being installed. [default: firefox] 13:58:44 INFO - mkdir: /builds/slave/test/build/application 13:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:59:01 INFO - Reading from file tmpfile_stdout 13:59:01 INFO - Output received: 13:59:01 INFO - /builds/slave/test/build/application/firefox/firefox 13:59:01 INFO - Running post-action listener: _resource_record_post_action 13:59:01 INFO - [mozharness: 2016-11-29 21:59:01.259781Z] Finished install step (success) 13:59:01 INFO - [mozharness: 2016-11-29 21:59:01.260021Z] Running run-tests step. 13:59:01 INFO - Running pre-action listener: _resource_record_pre_action 13:59:01 INFO - Running main action method: run_tests 13:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:59:01 INFO - Python 2.7.3 13:59:01 INFO - Return code: 0 13:59:01 INFO - grabbing minidump binary from tooltool 13:59: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')]} 13:59:01 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 0x2920fc0>, '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 0x2921ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2922350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:59:01 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 13:59:01 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 13:59:01 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 13:59:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:59:01 INFO - Return code: 0 13:59:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:59:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:59:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:59:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:59:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:59:01 INFO - Using env: {'DISPLAY': ':0', 13:59:01 INFO - 'HOME': '/home/cltbld', 13:59:01 INFO - 'LANG': 'en_US.UTF-8', 13:59:01 INFO - 'LANGUAGE': 'en_US:en', 13:59:01 INFO - 'LOGNAME': 'cltbld', 13:59:01 INFO - 'MAIL': '/var/mail/cltbld', 13:59:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:59:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:59:01 INFO - 'MOZ_NO_REMOTE': '1', 13:59:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:59:01 INFO - 'NO_EM_RESTART': '1', 13:59:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:59:01 INFO - 'PWD': '/builds/slave/test', 13:59:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:59:01 INFO - 'SHELL': '/bin/bash', 13:59:01 INFO - 'SHLVL': '1', 13:59:01 INFO - 'TERM': 'linux', 13:59:01 INFO - 'TMOUT': '86400', 13:59:01 INFO - 'USER': 'cltbld', 13:59:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781', 13:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:59:01 INFO - '_': '/tools/buildbot/bin/python'} 13:59:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:59:01 INFO - mozversion application_buildid: 20161129101109 13:59:01 INFO - mozversion application_changeset: b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 13:59:01 INFO - mozversion application_display_name: Nightly 13:59:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:59:01 INFO - mozversion application_name: Firefox 13:59:01 INFO - mozversion application_remotingname: firefox 13:59:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:59:01 INFO - mozversion application_vendor: Mozilla 13:59:01 INFO - mozversion application_version: 53.0a1 13:59:01 INFO - mozversion platform_buildid: 20161129101109 13:59:01 INFO - mozversion platform_changeset: b24e8ff760ba7b27b8ba2fceb9a90bd079b7bd19 13:59:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:59:01 INFO - mozversion platform_version: 53.0a1 13:59:01 INFO - using testdate: 1480456741 13:59:01 INFO - actual date: 1480456741 13:59:01 INFO - starting webserver on 'localhost:39125' 13:59:01 INFO - SUITE-START | Running 2 tests 13:59:01 INFO - TEST-START | dromaeo_css 13:59:01 INFO - operating with platform_type : linux_ 13:59:01 INFO - Initialising browser for dromaeo_css test... 13:59:01 INFO - TEST-INFO | started process 3318 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7nImK/profile http://localhost:39125/getInfo.html) 13:59:07 INFO - PROCESS | 3318 | __metrics Screen width/height:1600/1200 13:59:07 INFO - PROCESS | 3318 | colorDepth:24 13:59:07 INFO - PROCESS | 3318 | Browser inner width/height: 1024/697 13:59:07 INFO - PROCESS | 3318 | __metrics 13:59:08 INFO - PROCESS | 3318 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:59:08 INFO - PROCESS | 3318 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:59:09 INFO - PROCESS | 3318 | console.error: PushService: 13:59:09 INFO - PROCESS | 3318 | stateChangeProcessEnqueue: Error transitioning state 13:59:09 INFO - PROCESS | 3318 | UnknownError 13:59:10 INFO - TEST-INFO | 3318: exit 0 13:59:10 INFO - Browser initialized. 13:59:10 INFO - Running cycle 1/1 for dromaeo_css test... 13:59:10 INFO - TEST-INFO | started process 3400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb7nImK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:59:22 INFO - PROCESS | 3400 | RSS: Main: 173305856 13:59:22 INFO - PROCESS | 3400 | 14:00:13 INFO - PROCESS | 3400 | 1480456813481 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] 14:02:25 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39125/tests/dromaeo/cssquery-ext.html) 14:02:27 INFO - PROCESS | 3400 | RSS: Main: 315248640 14:02:27 INFO - PROCESS | 3400 | 14:05:29 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-ext.html (next: http://localhost:39125/tests/dromaeo/cssquery-jquery.html) 14:05:30 INFO - PROCESS | 3400 | RSS: Main: 275070976 14:05:30 INFO - PROCESS | 3400 | 14:08:32 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39125/tests/dromaeo/cssquery-mootools.html) 14:08:33 INFO - PROCESS | 3400 | RSS: Main: 225050624 14:08:33 INFO - PROCESS | 3400 | 14:11:35 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39125/tests/dromaeo/cssquery-prototype.html) 14:11:35 INFO - PROCESS | 3400 | RSS: Main: 282091520 14:11:35 INFO - PROCESS | 3400 | 14:14:38 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39125/tests/dromaeo/cssquery-yui.html) 14:14:39 INFO - PROCESS | 3400 | RSS: Main: 226152448 14:14:39 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:39125/tests/dromaeo/cssquery-yui.html (next: http://localhost:39125/tests/dromaeo/cssquery-dojo.html) 14:17:42 INFO - PROCESS | 3400 | RSS: Main: 283607040 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | __start_tp_report 14:17:42 INFO - PROCESS | 3400 | _x_x_mozilla_page_load 14:17:42 INFO - PROCESS | 3400 | _x_x_mozilla_page_load_details 14:17:42 INFO - PROCESS | 3400 | |i|pagename|runs| 14:17:42 INFO - PROCESS | 3400 | |0;dojo.html;3081.506958886578;3104.8758049678013;3114.2214446388402;3139.419207446621;3153.3377990621966;5237.397699264586;5298.09932311507;5325.068113080215;5361.785528578857;5376.704281264529;5374.596905232113;5379.623426360156;5380.112281473552;5387.865303367418;5410.513053825155;4850.078485087822;4878.195097808857;4893.04585605807;4903.534164254408;4919.458859525449;4870.293807397925;4933.580645645106;4935.037667654791;4936.580390666798;4938.80244790208;4840.927386089212;4886.902261954759;4900.362952816129;4905.82829600964;4935.407751069876;4938.283948827436;4944.579710724593;4954.9752251238515;4955.628327875424;4997.750112494361;4772.73749943753;4821.63837712173;4839.516048395132;4857.53853383928;4866.31871537985;5384.515393614593;5409.6213265071465;5435.755391007375;5442.945570544283;5487.012337779198;5812.82561523155;5869.471747542699;5870.148828419855;5873.471387575096;5875.588708790387;5755.482006619424;5835.153902684129;5842.941570584282;5925.259342582177;5932.9406705932815;5429.185622156708;5430.15832545956;5432.4839140282;5432.91850622241;5436.429174936654;5818.679972601463;5885.264341957255;5886.823395298148;5889.146073819272;5913.49735272498;5605.971970140124;5645.2096706461125;5646.548276137982;5692.174634677948;5748.511376533042;5709.400512946081;5715.742791574389;5718.571107166896;5722.11307247369;5723.284589426322;5606.187102870061;5712.400197979152;5713.771449142071;5714.7428365723645;5719.48524632785;5639.3232812062815;5644.6330988485615;5667.914981275284;5734.770609175586;5744.396838331999;4380.102079073782;4387.166438376698;4387.166438376698;4390.319500477367;4459.866204013885;3918.040080180374;3921.215756848642;3956.6834653227675;3958.5447673517338;3971.940420893631;5387.272718183073;5429.755660995264;5437.157240627709;5439.102548079522;5493.670379777226;5842.1236814477315;5844.766209351578;5844.970775146182;5851.765929362863;5896.705164741831;5503.889922201613;5522.144067669517;5525.751341189656;5528.834134975958;5530.253415788817;4933.753312334369;4970.229614409773;5005.6996580205305;5028.698278103326;5070.8225212117395;5951.1073338999495;6010.098485227251;6012.9098063529955;6057.545684073712;6064.3935606439;5776.624519406225;5811.186433899173;5815.389384114607;5825.184474173534;5828.417158284137;5839.036558967723;5883.794067207627;5948.434898684618;6003.249593800775;6016.187814645142;5726.484616384545;5731.140328950691;5747.339056008445;5780;5836.533077353886;5830.679312637845;5847.561432892465;5850.970745146417;5852.4147585241135;5854.531637468907;5477.315335583052;5700;5708.5147762439;5710.5717071219;5711.171880077449;5500.119980803052;5636.154576813511;5673.631213971079;5684.857878553069;5791.189233507396;5611.382747897646;5645.858853528694;5647.435256474319;5651.180578815966;5660.349059858169;5698.373178950229;5740.856478588069;5754.5684073695475;5757.884842303214;5759.078547432391;5422.05114105038;5437.864053398696;5447.12845944647;5514.172874068921;5519.144532597454 14:17:42 INFO - PROCESS | 3400 | |1;ext.html;559.555153652846;582.8921649494844;595.4759811365997;599.0983569727559;600.8948434024045;31692.68307316926;41273;42296.78851605738;42421.36367954483;45178.93389594936;43337;43760.562394376044;43899;43903.78048109763;43913.34129988053;7820.530768153929;8484.91515084849;8654.61054252557;8659.134086591353;8660.090690477504;7800.76597702067;10039.498025098752;10258.07677309042;10274.33216840903;10529.36823790575;10276.845847312296;10338.689839304796;10339.12117470016;10339.483025848715;10356.844647330296;10339.689809305695;10357.844632330522;10380.32527885685;10397.84403233952;10404.271700980935;10104.141148002429;10166.644167454178;10168.491575421273;10174.59301627934;10182.643607473703;40432;40554.18891622181;40556.59443405558;40802.38796418056;40808.591914080775;3302.9009129725905;3305.0910999475095;3411.4882767584813;3479.6172421033666;3661.6521430464063;28720.425591488263;30356.392872142434;30770.38459230825;31172.688273117205;32017;4097.569755175723;4114.465119534471;4180.561041090703;4239.97880010598;4374.5844144806515;325071;327537;329929;329946;332114;57546.71226643924;57885.71057144687;57983.42016579865;58024.419755802744;58038;60878.086828697604;60917;60927;60941;61069;15263.236838158047;15461.613459663598;15486.612834678997;15510.457134000257;15515.301811418512;10768;10992.780144397067;11683.182177247681;11723.4138293085;11756.58851940178;17334.739978900074;18027.40301223206;18314.17586208624;18364.173612187482;18526.258949641862;6638.96680516604;7131.372363567594;7174.784756457315;7199.820004499929;7203.747868824671;911.4394647291867;953.1231267234161;1004.6885465505717;1056.1392465140887;1095.5727266366123;30896.53655195174;30978.225544361572;31305.37389252202;31306.416625848582;31461.898833540716;1013.7060252526832;1019.3883669798211;1046.9110125639254;1073.6886302972207;1111.8999290063932;15807.652895453612;16549;16981.405650802164;17007.659846802995;17821.10894455272;456801;457786;460677;461595;462604;55818.72090639602;56064.71967640217;56139.43860561424;56313.43686563164;56397.43602563922;1180.1561883253514;1191.7676053169548;1301.7656821772362;1315.7697402954445;1327.8340207474066;27551.586726198722;31381.372372552876;31805.36389272248;31848.203794905312;31950.520742188422;48952.75523622359;49645.75177124091;49657;49704.25443618421;49715.50284497109;372298;373167;374295;376024;376326;24309.756902431458;27119.72880271172;27722.44555108927;27796.305092372044;28143.71856281411;43870;44264.33603496014;44374;45127.32309015433;45640.771796140805;37470.43794343033;37474.25051499009;37789.244215116094;38101.61898380981;39216.803915980236;37685.2462950734;37780.244395112495;37839.62160378361;37857.43213851739;38133.80933095317;37997.81001094977;38406.80796595999;38808.029799255244;38842.805785970886;38955;31695.52456713197;34171;34345.31309373749;34439.65560344465;35112.47331289982;26190.476190475703;26461.603075954263;26478.602820957316;26541.469170616092;26745.52439224921 14:17:42 INFO - PROCESS | 3400 | |2;jquery.html;362.1525630025739;380.6498021819925;383.7275534370595;387.7266527098396;405.2179293962653;14339.641508962268;17585.296588136476;18625.53436164095;19455.416337509898;19632.312869049587;17609.823901760978;17667.91166044168;17825.28698852044;17918;17983.100844957764;5440.211169380437;5745.224394706703;5755.165501002352;5755.798547050854;5755.82732518023;4178.874633760992;4307.310830267158;4325.935110973338;5581.581381396411;5677.48902598766;6256.937430625704;6375.617462952215;6379.393957574023;6383.202099737533;6386.904196437057;6057.606255593372;6203.627782333075;6236.189295391616;6359.586626869239;6374.808755737312;5402.37872644643;5402.594805389612;5416.0792665247;5437.8368648940595;5456.48163424474;21664.133434662595;21884.23405180811;21948.780512194833;21985.120595176173;22202.222922197645;2171.4245724882917;2465.1248806673552;2502.436951685874;2922.1671823530405;2983.194537474891;9890.456024918627;10221.080102790784;10330.58677652893;10334.328268662588;10369.222308326905;1590.395649653136;1624.2284914665559;1639.631083006326;1642.0476123848139;1684.284179223825;85135;85177.57411212905;85687;86162.5691871543;86343.13656863477;10353.585856565653;10559.260851740304;10588.417637030037;10771.407572583426;11072.224944253825;14520.273986300643;14532.927335363256;14546.636334091732;14552;14557.92721036388;7241.782746517613;7743.651535680908;7770.53376797394;7783.4162437817395;7893.210678932176;7203.605800461819;7255.383292420098;7255.818604534928;7433.962830185923;7448.547533230968;4439.467263928284;4476.888077798016;4552.88617784558;4559.338895860082;4607.746573938399;1924.8171423714725;1934.1006432009183;1954.189011560215;1978.891160986131;1987.8111579399933;833.8999320081629;929.6792606550729;931.5435436636;970.7767213540925;1007.8034783217203;18152.006558557096;19028.619427611648;19198.328058517884;19423.514412139528;19732.210711571377;926.3376685669643;969.4571040217501;974.8342781727123;989.8861630912393;1014.2494554030112;9798.559064842098;10797.514111864984;10848.250427273557;10873.728156795985;10893.509792059218;432998;438279;453551;456908;459173;91582.54208728914;92033;94172.52913735525;94542.52728736312;97250.51374743081;919.650532797546;937.6671281695036;943.5093751249449;952.3857112162616;964.7202311329776;16172.595685107966;16197.190140492692;16395.67208655844;16651.583710407336;17630.118494074988;42038.57961420347;42666;42914;43190.35214471848;44496.6896633993;52872.206916895506;54640.726796365765;54757.45242547523;54809.45190548043;56114.719426402604;5689.687067211343;8158.3065439438315;8159.632816523389;8271.421000529905;8313.127121652382;10511;12328;12579.811302830281;12709;12781.552645657357;10751.731206719895;10974.396408197306;11032.448377580928;11200.551977920792;11709.238899471507;10310.587576497157;10559.366438013743;10611.628592999208;10614.787704245717;10961.232713710282;10462.47687615601;10641.8935810644;11283.153763467608;11312;11409.828852567383;7995.800104997422;8174.795630109057;8198.467099638505;8264.752057438287;8294.543800091053;8441.577921104043;10436.53035613384;10636.84044739314;11136.443177841238;11145.387003714874 14:17:42 INFO - PROCESS | 3400 | |3;mootools.html;1317.1636011132928;1419.5315545869864;1455.148737988277;1564.6948844975227;1698.8131305556387;6708.429783468405;7409.666565004574;7708.421868359881;7718.112417072039;7889;7690.461667683265;7744.728934487294;7747.767566973;7759.573223472707;7762.883556746639;1920.8271255586994;1969.3402710092137;2246.618074927262;2280.908763649452;2288.6338185890263;2083.0938541734317;2134.8185404240658;2136.3377353020537;2137.593857167141;2140.0262880389387;2148.495103650641;2163.740351157863;2165.036558731365;2172.7609962904066;2173.9891300543477;2196.3191410662666;2205.38249290199;2206.2388475975763;2214.490667146565;2216.2464761981005;2116.0477784996815;2132.9573408531896;2137.5297434564527;2137.8717276963275;2138.155428605692;7530.43521735872;7572.39420846331;7575;7579.317861392446;7588.544687318778;4616.746078965655;4735.242361222188;4745.501722319142;4748.667593268473;4749.026449577828;3079.288688306872;3134.3104517006223;3150.228194092439;3211.951820722691;3221.130294820409;983.4541829284744;1048.2766890845292;1076.1498416251152;1089.0470838016736;1129.170060005895;10322.690319290508;10413.062824345845;10422.583096676124;10460.163186945027;10475.947620261926;4060.634542891154;4306.698531102793;4363.258246098171;4393.384926110347;4398;8862;8872.8669069964;8880.289576833839;8888.688895888612;8891.866622000674;4692.085043416501;4693.530646935279;4700.506446823103;4703;4703.318018887242;3699.5190625218547;4151.481064866892;4354.804033818486;4356.542563030899;4361.6510679145595;3658.5975542690285;3673.8714145005333;3780.2628487444686;3794.165283637595;3807.6763475104926;1219.8475190601175;1246.6883279180206;1275.7257189704258;1285.2609749393948;1293.2886912198253;898.2544488074882;914.6752902719572;927.3786563002805;929.312308891429;946.2950102173787;5412.377576578665;5425.159100339453;5531.723413829292;5545.306836645419;5611.551075913999;886.9113088691208;893.0890491698431;898.9640414383351;903.114947351586;910.3536489092686;3663.9633603664156;3722.4737857478303;3730.515033045687;3751.1934933989323;3835.53973523179;9038.322125840588;9319.534023298944;9400.200982916529;9404;9409.623615055458;9395.107464790834;9439.669611563562;9460.290478214161;9470.384425012353;9474.621015159455;7242.710291588278;7396.482246242711;7400.555966642019;7413.777586672409;7414.592197429085;5098.821541246039;5289.7355132242465;5337.119375303031;5368.355797304349;5607.467290607386;8495;8584.957075214834;8705.608247629;8741.606627701642;8751.993520745196;8808.339374547062;8835.514046727492;8909.287257019552;8972.19250267453;8995.280377569648;6055.485283750931;6412.454941330039;6536.901946470902;6578.388294867788;6594.604323740591;6826.351496607815;7169.641517924188;7413.777586672409;7437.8140546486775;7554.395648348009;6583.703733331916;6686.5653732507235;6713.362230588086;6867.793966181022;6903.1371078615175;6629.900551491828;6729.629870357177;6730.899036514358;6827.385535301847;6870.62211578368;6078.817635470943;6177.166082578794;6179.721912513858;6186.381361863778;6190.2571691397325;4546.13623411564;4643.466001409746;4647.976760116313;4673.7429441381055;4741.2651039089;4827;4935.531124543163;4940.604751619933;5069.898602028013;5090.516400941905 14:17:42 INFO - PROCESS | 3400 | |4;prototype.html;309.1436720284811;326.54610091972165;328.8125768312062;330.0511030786489;332.91011426914724;4986.227134794112;5282.124845679786;5317.335333083364;5362.2224777407255;5381.81163659272;5253.57971362291;5260.605454590911;5261.973690131554;5277.097596322017;5302.496262855032;4153.730007549515;4166.6874984376145;4167.312393455076;4183.979080104596;4206.686322522615;4081.7142800004012;4181.519125300599;4191.098913733546;4195.098053918407;4197.643200327976;4125.422440858282;4132.731372460796;4146.792660366985;4147.191297696951;4148.605882441163;4129.421880936671;4138.524069731974;4143.357779544175;4144.357624568182;4157.293260145752;3684.778913265213;3690.538682664667;3706.369197553068;3725.3853114236117;3730.3658378075793;5091.898162036776;5155.304033955405;5166.199239117906;5173.224016397533;5176.705823544114;4718.457377401574;4718.504557021498;4726.314684370747;4731;4750.12122757291;5573.526250268732;5581.274434323553;5582.358028826697;5600.691961942091;5602.7758889644365;3787.886363409102;3932.193900250442;3955.307821131319;3957.9010524736823;3969.5435024972207;5457.072297709399;5572.804951826707;5680.3467601225975;5727.570432217601;5747.683877386742;3951.0122469382654;3963.672169823084;3984.7409918355215;4001.47980762499;4004.4193591929006;4039.434479172918;4075.694322925792;4077.9796101019306;4080.489938757655;4084.223997440477;4453.710508816981;4487.842925497657;4661.883452913637;4676.625869930397;4688.812447502061;5286;5459.863503412446;5507.807226747044;5511.917321240185;5514.365847927459;1349.284879014124;1360.605424426905;1364.433759989613;1367.994524024841;1372.2726954714017;879.366855863777;937.9448120864027;938.7512309238058;951.4909523405083;969.1519920069939;5115.411727651293;5198.9740051299505;5217.426083130853;5244;5285.973570132125;5459.317585301837;5486.643368181056;5502.202180683778;5548.389677135512;5560.360558535739;5096.923546146737;5168.19892916591;5208.739563021833;5228.503292187236;5235.476452354734;2939.3974235281717;2944.7791415643483;2947.675755666875;2954.49773538499;2962.674105848398;5672.631278966854;5719;5728.455796699307;5756.481916627524;5761.279840019997;5423.810166644149;5460.726963651801;5476.412949518072;5493.752781124859;5668.376478587352;5511.338639363302;5626.2967129108865;5678.971605141948;5721.942780572307;5725.685087320321;5358.35699716021;5509.622594351412;5525.778968841201;5551.195076713934;5576;5434.728263586884;5435.266239057677;5436.483534064258;5444.156155795699;5463.207834864002;5624.184493248375;5666.320041595035;5670.773169073191;5732.936142988604;5746.5402767779315;3924.372100463912;3983.402489626579;3997.360422332413;4012.859549915739;4024.315866302794;5655.293088363955;5669.659820410789;5674.432556744293;5679.886402271849;5684.403137670485;5327.573794096385;5500.80747173847;5501.697406642673;5543.501084902378;5548.500634942875;5455.727213639223;5472.370677371994;5482.506574408322;5483.177523371526;5490.5882058844945;5381.73091345439;5406.162044883049;5406.5945054121885;5413.9729301353245;5415.945840541702;5349.652272602424;5492.697901615449;5513.3108361454815;5517.393086760373;5538.224648549126;5364.444311149723;5397.298351214317;5416.160495123262;5421.376541697755;5442.292501974718 14:17:42 INFO - PROCESS | 3400 | |5;yui.html;720.2390156068412;727.4798519058869;767.3094215206314;775.806048487878;814.4014149600044;13974.441022359106;14801.925990370033;14849.851501484982;14864;14930.626734331634;13245.668858278548;13390.59828205153;13411.12827666201;13412.865871341284;13425.798613020812;661.9702113404908;679.7620832708562;750.8423231121471;770.9845803083934;776.2392855002101;771.3751860992614;777.2150128370358;777.3975169243853;780.0444455541973;780.0600276666603;832.2842355574231;834.1991687979516;834.2408408348405;834.486790623765;834.7287131682198;693.5145398221265;706.3148745716646;824.9133840946735;828.1470085811624;828.1718281718282;602.8492876780805;608.2518502242223;608.7047781825811;609.329737288983;609.4545381883235;15545.22273886301;15559;15684.529464116094;15781.526554203392;15784.605384865356;14488.420463181461;14511.927440362731;14757.852421475754;14957.551273461813;14985.700285994219;11651.475683594259;11672.708182295426;11879.703007424883;12041.578544750892;12390.5663301784;3534.6995505382074;3639.290338384016;3647.6534729200685;3765.7175711821724;3767.773933563995;84253.31322593847;85682.57158714229;86389;86729;87636.56181719115;11499.885001150049;11508;11530.19718366168;11541.192116551929;11767.293962362286;21732;21883.562328753334;21902.23342183016;21927.890360548416;22332.33003009912;7684.116326622398;7800.531968081933;7885.487443316166;8034.879476807852;8041.798955026171;4352.673549483801;4376.081022985145;4396.164728701537;4421.911561768747;4458.242098843204;3407;3485.0590340607896;3523.224890524081;3523.6652518010746;3525.753197276217;564.5455408396281;570.7003822992962;573.6644063223061;581.5551103405897;586.4721750424567;548.3310361359136;550.6668465578348;567.140781715701;569.2059576890215;575.1746244139673;9043.412178208395;9122;9313.767155821024;9320.8601870972;9449.987795218698;562.3364429972671;615.8429600451856;644.6615526848349;651.4495251512465;655.3282885042869;4218.388333691659;4306.504751953503;4329.718568293051;4387.319965405367;4402.735835849795;82649.58675206585;82912.58543707243;83331.5833420829;83566.58216708878;87103;61154;61702.38297616966;62225.37774622286;62712.68643656753;64325.78371081427;57039.429605703415;57645.42354576485;58312;59634;59658;8465.873011904703;9431.905680943377;9601.663941762004;9617.182539484222;9646.951765241129;40091.599084009955;40369.39445908373;41113;41848.79075604602;42320.57679423167;41262.38106428346;42356;48744.512554875415;49064.509354906;53611;11783.234089784137;11785.292882427082;11788.823167652321;11940.223885447418;12418.192817466836;13593.86406135926;13759.518416855362;13997.440102396198;14220.786688199478;14358.641033974234;12245.571405000783;12281.815772763595;12775.425105870072;13066.738665226832;13375.402498230302;12375.876241237473;12550.497980080694;12661.873381266438;13012.739745204854;13519.121257118255;12007.245837365623;12555.094697916293;12662.303573303188;12775.361231938552;12849.164804287691;9871.703848884545;10149.188064954638;10250.743731406475;10310.587576497157;10520.421376824042;9302.581383837609;9809.313348065567;10346.896531034594;11287.943560282147;11359.432028398382 14:17:42 INFO - PROCESS | 3400 | __end_tp_report 14:17:42 INFO - PROCESS | 3400 | __start_cc_report 14:17:42 INFO - PROCESS | 3400 | _x_x_mozilla_cycle_collect,1407 14:17:42 INFO - PROCESS | 3400 | __end_cc_report 14:17:42 INFO - PROCESS | 3400 | __startTimestamp1480457862328__endTimestamp 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | ------- Summary: start ------- 14:17:42 INFO - PROCESS | 3400 | Number of tests: 6 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#0] dojo.html Cycles:165 Average:5371.61 Median:5605.97 stddev:616.91 (11.0%) stddev-sans-first:592.06 14:17:42 INFO - PROCESS | 3400 | Values: 3081.5 3104.9 3114.2 3139.4 3153.3 5237.4 5298.1 5325.1 5361.8 5376.7 5374.6 5379.6 5380.1 5387.9 5410.5 4850.1 4878.2 4893.0 4903.5 4919.5 4870.3 4933.6 4935.0 4936.6 4938.8 4840.9 4886.9 4900.4 4905.8 4935.4 4938.3 4944.6 4955.0 4955.6 4997.8 4772.7 4821.6 4839.5 4857.5 4866.3 5384.5 5409.6 5435.8 5442.9 5487.0 5812.8 5869.5 5870.1 5873.5 5875.6 5755.5 5835.2 5842.9 5925.3 5932.9 5429.2 5430.2 5432.5 5432.9 5436.4 5818.7 5885.3 5886.8 5889.1 5913.5 5606.0 5645.2 5646.5 5692.2 5748.5 5709.4 5715.7 5718.6 5722.1 5723.3 5606.2 5712.4 5713.8 5714.7 5719.5 5639.3 5644.6 5667.9 5734.8 5744.4 4380.1 4387.2 4387.2 4390.3 4459.9 3918.0 3921.2 3956.7 3958.5 3971.9 5387.3 5429.8 5437.2 5439.1 5493.7 5842.1 5844.8 5845.0 5851.8 5896.7 5503.9 5522.1 5525.8 5528.8 5530.3 4933.8 4970.2 5005.7 5028.7 5070.8 5951.1 6010.1 6012.9 6057.5 6064.4 5776.6 5811.2 5815.4 5825.2 5828.4 5839.0 5883.8 5948.4 6003.2 6016.2 5726.5 5731.1 5747.3 5780.0 5836.5 5830.7 5847.6 5851.0 5852.4 5854.5 5477.3 5700.0 5708.5 5710.6 5711.2 5500.1 5636.2 5673.6 5684.9 5791.2 5611.4 5645.9 5647.4 5651.2 5660.3 5698.4 5740.9 5754.6 5757.9 5759.1 5422.1 5437.9 5447.1 5514.2 5519.1 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#1] ext.html Cycles:180 Average:55041.74 Median:19296.05 stddev:103311.77 (535.4%) stddev-sans-first:103520.60 14:17:42 INFO - PROCESS | 3400 | Values: 559.6 582.9 595.5 599.1 600.9 31692.7 41273.0 42296.8 42421.4 45178.9 43337.0 43760.6 43899.0 43903.8 43913.3 7820.5 8484.9 8654.6 8659.1 8660.1 7800.8 10039.5 10258.1 10274.3 10529.4 10276.8 10338.7 10339.1 10339.5 10356.8 10339.7 10357.8 10380.3 10397.8 10404.3 10104.1 10166.6 10168.5 10174.6 10182.6 40432.0 40554.2 40556.6 40802.4 40808.6 3302.9 3305.1 3411.5 3479.6 3661.7 28720.4 30356.4 30770.4 31172.7 32017.0 4097.6 4114.5 4180.6 4240.0 4374.6 325071.0 327537.0 329929.0 329946.0 332114.0 57546.7 57885.7 57983.4 58024.4 58038.0 60878.1 60917.0 60927.0 60941.0 61069.0 15263.2 15461.6 15486.6 15510.5 15515.3 10768.0 10992.8 11683.2 11723.4 11756.6 17334.7 18027.4 18314.2 18364.2 18526.3 6639.0 7131.4 7174.8 7199.8 7203.7 911.4 953.1 1004.7 1056.1 1095.6 30896.5 30978.2 31305.4 31306.4 31461.9 1013.7 1019.4 1046.9 1073.7 1111.9 15807.7 16549.0 16981.4 17007.7 17821.1 456801.0 457786.0 460677.0 461595.0 462604.0 55818.7 56064.7 56139.4 56313.4 56397.4 1180.2 1191.8 1301.8 1315.8 1327.8 27551.6 31381.4 31805.4 31848.2 31950.5 48952.8 49645.8 49657.0 49704.3 49715.5 372298.0 373167.0 374295.0 376024.0 376326.0 24309.8 27119.7 27722.4 27796.3 28143.7 43870.0 44264.3 44374.0 45127.3 45640.8 37470.4 37474.3 37789.2 38101.6 39216.8 37685.2 37780.2 37839.6 37857.4 38133.8 37997.8 38406.8 38808.0 38842.8 38955.0 31695.5 34171.0 34345.3 34439.7 35112.5 26190.5 26461.6 26478.6 26541.5 26745.5 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#2] jquery.html Cycles:180 Average:27602.15 Median:42352.29 stddev:74355.12 (175.6%) stddev-sans-first:74535.57 14:17:42 INFO - PROCESS | 3400 | Values: 362.2 380.6 383.7 387.7 405.2 14339.6 17585.3 18625.5 19455.4 19632.3 17609.8 17667.9 17825.3 17918.0 17983.1 5440.2 5745.2 5755.2 5755.8 5755.8 4178.9 4307.3 4325.9 5581.6 5677.5 6256.9 6375.6 6379.4 6383.2 6386.9 6057.6 6203.6 6236.2 6359.6 6374.8 5402.4 5402.6 5416.1 5437.8 5456.5 21664.1 21884.2 21948.8 21985.1 22202.2 2171.4 2465.1 2502.4 2922.2 2983.2 9890.5 10221.1 10330.6 10334.3 10369.2 1590.4 1624.2 1639.6 1642.0 1684.3 85135.0 85177.6 85687.0 86162.6 86343.1 10353.6 10559.3 10588.4 10771.4 11072.2 14520.3 14532.9 14546.6 14552.0 14557.9 7241.8 7743.7 7770.5 7783.4 7893.2 7203.6 7255.4 7255.8 7434.0 7448.5 4439.5 4476.9 4552.9 4559.3 4607.7 1924.8 1934.1 1954.2 1978.9 1987.8 833.9 929.7 931.5 970.8 1007.8 18152.0 19028.6 19198.3 19423.5 19732.2 926.3 969.5 974.8 989.9 1014.2 9798.6 10797.5 10848.3 10873.7 10893.5 432998.0 438279.0 453551.0 456908.0 459173.0 91582.5 92033.0 94172.5 94542.5 97250.5 919.7 937.7 943.5 952.4 964.7 16172.6 16197.2 16395.7 16651.6 17630.1 42038.6 42666.0 42914.0 43190.4 44496.7 52872.2 54640.7 54757.5 54809.5 56114.7 5689.7 8158.3 8159.6 8271.4 8313.1 10511.0 12328.0 12579.8 12709.0 12781.6 10751.7 10974.4 11032.4 11200.6 11709.2 10310.6 10559.4 10611.6 10614.8 10961.2 10462.5 10641.9 11283.2 11312.0 11409.8 7995.8 8174.8 8198.5 8264.8 8294.5 8441.6 10436.5 10636.8 11136.4 11145.4 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#3] mootools.html Cycles:180 Average:5128.09 Median:5313.43 stddev:2777.16 (52.3%) stddev-sans-first:2770.18 14:17:42 INFO - PROCESS | 3400 | Values: 1317.2 1419.5 1455.1 1564.7 1698.8 6708.4 7409.7 7708.4 7718.1 7889.0 7690.5 7744.7 7747.8 7759.6 7762.9 1920.8 1969.3 2246.6 2280.9 2288.6 2083.1 2134.8 2136.3 2137.6 2140.0 2148.5 2163.7 2165.0 2172.8 2174.0 2196.3 2205.4 2206.2 2214.5 2216.2 2116.0 2133.0 2137.5 2137.9 2138.2 7530.4 7572.4 7575.0 7579.3 7588.5 4616.7 4735.2 4745.5 4748.7 4749.0 3079.3 3134.3 3150.2 3212.0 3221.1 983.5 1048.3 1076.1 1089.0 1129.2 10322.7 10413.1 10422.6 10460.2 10475.9 4060.6 4306.7 4363.3 4393.4 4398.0 8862.0 8872.9 8880.3 8888.7 8891.9 4692.1 4693.5 4700.5 4703.0 4703.3 3699.5 4151.5 4354.8 4356.5 4361.7 3658.6 3673.9 3780.3 3794.2 3807.7 1219.8 1246.7 1275.7 1285.3 1293.3 898.3 914.7 927.4 929.3 946.3 5412.4 5425.2 5531.7 5545.3 5611.6 886.9 893.1 899.0 903.1 910.4 3664.0 3722.5 3730.5 3751.2 3835.5 9038.3 9319.5 9400.2 9404.0 9409.6 9395.1 9439.7 9460.3 9470.4 9474.6 7242.7 7396.5 7400.6 7413.8 7414.6 5098.8 5289.7 5337.1 5368.4 5607.5 8495.0 8585.0 8705.6 8741.6 8752.0 8808.3 8835.5 8909.3 8972.2 8995.3 6055.5 6412.5 6536.9 6578.4 6594.6 6826.4 7169.6 7413.8 7437.8 7554.4 6583.7 6686.6 6713.4 6867.8 6903.1 6629.9 6729.6 6730.9 6827.4 6870.6 6078.8 6177.2 6179.7 6186.4 6190.3 4546.1 4643.5 4648.0 4673.7 4741.3 4827.0 4935.5 4940.6 5069.9 5090.5 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#4] prototype.html Cycles:180 Average:4609.03 Median:5285.99 stddev:1340.48 (25.4%) stddev-sans-first:1304.81 14:17:42 INFO - PROCESS | 3400 | Values: 309.1 326.5 328.8 330.1 332.9 4986.2 5282.1 5317.3 5362.2 5381.8 5253.6 5260.6 5262.0 5277.1 5302.5 4153.7 4166.7 4167.3 4184.0 4206.7 4081.7 4181.5 4191.1 4195.1 4197.6 4125.4 4132.7 4146.8 4147.2 4148.6 4129.4 4138.5 4143.4 4144.4 4157.3 3684.8 3690.5 3706.4 3725.4 3730.4 5091.9 5155.3 5166.2 5173.2 5176.7 4718.5 4718.5 4726.3 4731.0 4750.1 5573.5 5581.3 5582.4 5600.7 5602.8 3787.9 3932.2 3955.3 3957.9 3969.5 5457.1 5572.8 5680.3 5727.6 5747.7 3951.0 3963.7 3984.7 4001.5 4004.4 4039.4 4075.7 4078.0 4080.5 4084.2 4453.7 4487.8 4661.9 4676.6 4688.8 5286.0 5459.9 5507.8 5511.9 5514.4 1349.3 1360.6 1364.4 1368.0 1372.3 879.4 937.9 938.8 951.5 969.2 5115.4 5199.0 5217.4 5244.0 5286.0 5459.3 5486.6 5502.2 5548.4 5560.4 5096.9 5168.2 5208.7 5228.5 5235.5 2939.4 2944.8 2947.7 2954.5 2962.7 5672.6 5719.0 5728.5 5756.5 5761.3 5423.8 5460.7 5476.4 5493.8 5668.4 5511.3 5626.3 5679.0 5721.9 5725.7 5358.4 5509.6 5525.8 5551.2 5576.0 5434.7 5435.3 5436.5 5444.2 5463.2 5624.2 5666.3 5670.8 5732.9 5746.5 3924.4 3983.4 3997.4 4012.9 4024.3 5655.3 5669.7 5674.4 5679.9 5684.4 5327.6 5500.8 5501.7 5543.5 5548.5 5455.7 5472.4 5482.5 5483.2 5490.6 5381.7 5406.2 5406.6 5414.0 5415.9 5349.7 5492.7 5513.3 5517.4 5538.2 5364.4 5397.3 5416.2 5421.4 5442.3 14:17:42 INFO - PROCESS | 3400 | 14:17:42 INFO - PROCESS | 3400 | [#5] yui.html Cycles:180 Average:17121.14 Median:4399.45 stddev:22491.82 (511.2%) stddev-sans-first:22521.20 14:17:42 INFO - PROCESS | 3400 | Values: 720.2 727.5 767.3 775.8 814.4 13974.4 14801.9 14849.9 14864.0 14930.6 13245.7 13390.6 13411.1 13412.9 13425.8 662.0 679.8 750.8 771.0 776.2 771.4 777.2 777.4 780.0 780.1 832.3 834.2 834.2 834.5 834.7 693.5 706.3 824.9 828.1 828.2 602.8 608.3 608.7 609.3 609.5 15545.2 15559.0 15684.5 15781.5 15784.6 14488.4 14511.9 14757.9 14957.6 14985.7 11651.5 11672.7 11879.7 12041.6 12390.6 3534.7 3639.3 3647.7 3765.7 3767.8 84253.3 85682.6 86389.0 86729.0 87636.6 11499.9 11508.0 11530.2 11541.2 11767.3 21732.0 21883.6 21902.2 21927.9 22332.3 7684.1 7800.5 7885.5 8034.9 8041.8 4352.7 4376.1 4396.2 4421.9 4458.2 3407.0 3485.1 3523.2 3523.7 3525.8 564.5 570.7 573.7 581.6 586.5 548.3 550.7 567.1 569.2 575.2 9043.4 9122.0 9313.8 9320.9 9450.0 562.3 615.8 644.7 651.4 655.3 4218.4 4306.5 4329.7 4387.3 4402.7 82649.6 82912.6 83331.6 83566.6 87103.0 61154.0 61702.4 62225.4 62712.7 64325.8 57039.4 57645.4 58312.0 59634.0 59658.0 8465.9 9431.9 9601.7 9617.2 9647.0 40091.6 40369.4 41113.0 41848.8 42320.6 41262.4 42356.0 48744.5 49064.5 53611.0 11783.2 11785.3 11788.8 11940.2 12418.2 13593.9 13759.5 13997.4 14220.8 14358.6 12245.6 12281.8 12775.4 13066.7 13375.4 12375.9 12550.5 12661.9 13012.7 13519.1 12007.2 12555.1 12662.3 12775.4 12849.2 9871.7 10149.2 10250.7 10310.6 10520.4 9302.6 9809.3 10346.9 11287.9 11359.4 14:17:42 INFO - PROCESS | 3400 | -------- Summary: end -------- 14:17:42 INFO - PROCESS | 3400 | 14:17:43 INFO - TEST-INFO | 3400: exit 0 14:17:43 INFO - TEST-OK | dromaeo_css | took 1121545ms 14:17:43 INFO - TEST-START | kraken 14:17:43 INFO - operating with platform_type : linux_ 14:17:43 INFO - Initialising browser for kraken test... 14:17:43 INFO - TEST-INFO | started process 3709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pb_OP/profile http://localhost:39125/getInfo.html) 14:17:47 INFO - PROCESS | 3709 | __metrics Screen width/height:1600/1200 14:17:47 INFO - PROCESS | 3709 | colorDepth:24 14:17:47 INFO - PROCESS | 3709 | Browser inner width/height: 1024/697 14:17:47 INFO - PROCESS | 3709 | __metrics 14:17:48 INFO - PROCESS | 3709 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:17:48 INFO - PROCESS | 3709 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:17:48 INFO - PROCESS | 3709 | console.error: PushService: 14:17:48 INFO - PROCESS | 3709 | stateChangeProcessEnqueue: Error transitioning state 14:17:48 INFO - PROCESS | 3709 | UnknownError 14:17:49 INFO - TEST-INFO | 3709: exit 0 14:17:49 INFO - Browser initialized. 14:17:49 INFO - Running cycle 1/1 for kraken test... 14:17:49 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1pb_OP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:01 INFO - PROCESS | 3790 | RSS: Main: 173817856 14:18:01 INFO - PROCESS | 3790 | 14:18:04 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-beat-detection) 14:18:05 INFO - PROCESS | 3790 | RSS: Main: 235433984 14:18:05 INFO - PROCESS | 3790 | 14:18:07 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-dft) 14:18:08 INFO - PROCESS | 3790 | RSS: Main: 217530368 14:18:08 INFO - PROCESS | 3790 | 14:18:11 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-fft) 14:18:11 INFO - PROCESS | 3790 | RSS: Main: 299450368 14:18:11 INFO - PROCESS | 3790 | 14:18:13 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39125/tests/kraken/driver.html?testName=audio-oscillator) 14:18:14 INFO - PROCESS | 3790 | RSS: Main: 209866752 14:18:14 INFO - PROCESS | 3790 | 14:18:16 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:18:17 INFO - PROCESS | 3790 | RSS: Main: 214745088 14:18:17 INFO - PROCESS | 3790 | 14:18:20 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-darkroom) 14:18:20 INFO - PROCESS | 3790 | RSS: Main: 254300160 14:18:20 INFO - PROCESS | 3790 | 14:18:24 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39125/tests/kraken/driver.html?testName=imaging-desaturate) 14:18:24 INFO - PROCESS | 3790 | RSS: Main: 252960768 14:18:24 INFO - PROCESS | 3790 | 14:18:27 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39125/tests/kraken/driver.html?testName=json-parse-financial) 14:18:28 INFO - PROCESS | 3790 | RSS: Main: 252395520 14:18:28 INFO - PROCESS | 3790 | 14:18:29 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39125/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:18:30 INFO - PROCESS | 3790 | RSS: Main: 214515712 14:18:30 INFO - PROCESS | 3790 | 14:18:32 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:18:32 INFO - PROCESS | 3790 | RSS: Main: 221884416 14:18:32 INFO - PROCESS | 3790 | 14:18:35 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:18:36 INFO - PROCESS | 3790 | RSS: Main: 230252544 14:18:36 INFO - PROCESS | 3790 | 14:18:38 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:18:39 INFO - PROCESS | 3790 | RSS: Main: 240009216 14:18:39 INFO - PROCESS | 3790 | 14:18:42 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:18:43 INFO - PROCESS | 3790 | RSS: Main: 236167168 14:18:43 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:39125/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39125/tests/kraken/driver.html?testName=ai-astar) 14:18:44 INFO - PROCESS | 3790 | RSS: Main: 288169984 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | __start_tp_report 14:18:44 INFO - PROCESS | 3790 | _x_x_mozilla_page_load 14:18:44 INFO - PROCESS | 3790 | _x_x_mozilla_page_load_details 14:18:44 INFO - PROCESS | 3790 | |i|pagename|runs| 14:18:44 INFO - PROCESS | 3790 | |0;ai-astar;111;114;113;112;115;113;113;112;112;113 14:18:44 INFO - PROCESS | 3790 | |1;audio-beat-detection;153;122;126;159;123;123;126;124;144;132 14:18:44 INFO - PROCESS | 3790 | |2;audio-dft;161;159;160;160;161;161;162;161;160;161 14:18:44 INFO - PROCESS | 3790 | |3;audio-fft;77;75;74;131;78;76;75;77;90;76 14:18:44 INFO - PROCESS | 3790 | |4;audio-oscillator;82;83;106;83;83;82;95;81;82;111 14:18:44 INFO - PROCESS | 3790 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;118 14:18:44 INFO - PROCESS | 3790 | |6;imaging-darkroom;146;146;146;145;145;147;146;146;146;146 14:18:44 INFO - PROCESS | 3790 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;96 14:18:44 INFO - PROCESS | 3790 | |8;json-parse-financial;52;52;51;51;52;53;53;53;51;53 14:18:44 INFO - PROCESS | 3790 | |9;json-stringify-tinderbox;61;61;62;61;62;61;61;61;61;62 14:18:44 INFO - PROCESS | 3790 | |10;stanford-crypto-aes;80;81;80;90;83;87;80;81;82;80 14:18:44 INFO - PROCESS | 3790 | |11;stanford-crypto-ccm;134;133;134;155;131;134;140;128;180;130 14:18:44 INFO - PROCESS | 3790 | |12;stanford-crypto-pbkdf2;165;164;165;165;166;165;165;169;166;169 14:18:44 INFO - PROCESS | 3790 | |13;stanford-crypto-sha256-iterative;66;67;65;66;69;65;66;65;65;64 14:18:44 INFO - PROCESS | 3790 | __end_tp_report 14:18:44 INFO - PROCESS | 3790 | __start_cc_report 14:18:44 INFO - PROCESS | 3790 | _x_x_mozilla_cycle_collect,1694 14:18:44 INFO - PROCESS | 3790 | __end_cc_report 14:18:44 INFO - PROCESS | 3790 | __startTimestamp1480457924946__endTimestamp 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | ------- Summary: start ------- 14:18:44 INFO - PROCESS | 3790 | Number of tests: 14 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.14 (1.0%) stddev-sans-first:1.00 14:18:44 INFO - PROCESS | 3790 | Values: 111.0 114.0 113.0 112.0 115.0 113.0 113.0 112.0 112.0 113.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:129.00 stddev:13.73 (10.6%) stddev-sans-first:12.56 14:18:44 INFO - PROCESS | 3790 | Values: 153.0 122.0 126.0 159.0 123.0 123.0 126.0 124.0 144.0 132.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.84 (0.5%) stddev-sans-first:0.88 14:18:44 INFO - PROCESS | 3790 | Values: 161.0 159.0 160.0 160.0 161.0 161.0 162.0 161.0 160.0 161.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:17.50 (22.9%) stddev-sans-first:18.43 14:18:44 INFO - PROCESS | 3790 | Values: 77.0 75.0 74.0 131.0 78.0 76.0 75.0 77.0 90.0 76.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:82.50 stddev:11.19 (13.6%) stddev-sans-first:11.60 14:18:44 INFO - PROCESS | 3790 | Values: 82.0 83.0 106.0 83.0 83.0 82.0 95.0 81.0 82.0 111.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 14:18:44 INFO - PROCESS | 3790 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:18:44 INFO - PROCESS | 3790 | Values: 146.0 146.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 146.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:18:44 INFO - PROCESS | 3790 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.93 14:18:44 INFO - PROCESS | 3790 | Values: 52.0 52.0 51.0 51.0 52.0 53.0 53.0 53.0 51.0 53.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 14:18:44 INFO - PROCESS | 3790 | Values: 61.0 61.0 62.0 61.0 62.0 61.0 61.0 61.0 61.0 62.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.50 stddev:3.44 (4.2%) stddev-sans-first:3.54 14:18:44 INFO - PROCESS | 3790 | Values: 80.0 81.0 80.0 90.0 83.0 87.0 80.0 81.0 82.0 80.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:134.00 stddev:16.01 (11.9%) stddev-sans-first:16.84 14:18:44 INFO - PROCESS | 3790 | Values: 134.0 133.0 134.0 155.0 131.0 134.0 140.0 128.0 180.0 130.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:165.50 stddev:1.73 (1.0%) stddev-sans-first:1.80 14:18:44 INFO - PROCESS | 3790 | Values: 165.0 164.0 165.0 165.0 166.0 165.0 165.0 169.0 166.0 169.0 14:18:44 INFO - PROCESS | 3790 | 14:18:44 INFO - PROCESS | 3790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 14:18:44 INFO - PROCESS | 3790 | Values: 66.0 67.0 65.0 66.0 69.0 65.0 66.0 65.0 65.0 64.0 14:18:44 INFO - PROCESS | 3790 | -------- Summary: end -------- 14:18:44 INFO - PROCESS | 3790 | 14:18:46 INFO - TEST-INFO | 3790: exit 0 14:18:46 INFO - TEST-OK | kraken | took 62914ms 14:18:46 INFO - SUITE-END | took 1184s 14:18:46 INFO - Completed test suite (00:19:44) 14:18:46 INFO - javascript benchmark 14:18:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.506958886578, 3104.8758049678013, 3114.2214446388402, 3139.419207446621, 3153.3377990621966, 5237.397699264586, 5298.09932311507, 5325.068113080215, 5361.785528578857, 5376.704281264529, 5374.596905232113, 5379.623426360156, 5380.112281473552, 5387.865303367418, 5410.513053825155, 4850.078485087822, 4878.195097808857, 4893.04585605807, 4903.534164254408, 4919.458859525449, 4870.293807397925, 4933.580645645106, 4935.037667654791, 4936.580390666798, 4938.80244790208, 4840.927386089212, 4886.902261954759, 4900.362952816129, 4905.82829600964, 4935.407751069876, 4938.283948827436, 4944.579710724593, 4954.9752251238515, 4955.628327875424, 4997.750112494361, 4772.73749943753, 4821.63837712173, 4839.516048395132, 4857.53853383928, 4866.31871537985, 5384.515393614593, 5409.6213265071465, 5435.755391007375, 5442.945570544283, 5487.012337779198, 5812.82561523155, 5869.471747542699, 5870.148828419855, 5873.471387575096, 5875.588708790387, 5755.482006619424, 5835.153902684129, 5842.941570584282, 5925.259342582177, 5932.9406705932815, 5429.185622156708, 5430.15832545956, 5432.4839140282, 5432.91850622241, 5436.429174936654, 5818.679972601463, 5885.264341957255, 5886.823395298148, 5889.146073819272, 5913.49735272498, 5605.971970140124, 5645.2096706461125, 5646.548276137982, 5692.174634677948, 5748.511376533042, 5709.400512946081, 5715.742791574389, 5718.571107166896, 5722.11307247369, 5723.284589426322, 5606.187102870061, 5712.400197979152, 5713.771449142071, 5714.7428365723645, 5719.48524632785, 5639.3232812062815, 5644.6330988485615, 5667.914981275284, 5734.770609175586, 5744.396838331999, 4380.102079073782, 4387.166438376698, 4387.166438376698, 4390.319500477367, 4459.866204013885, 3918.040080180374, 3921.215756848642, 3956.6834653227675, 3958.5447673517338, 3971.940420893631, 5387.272718183073, 5429.755660995264, 5437.157240627709, 5439.102548079522, 5493.670379777226, 5842.1236814477315, 5844.766209351578, 5844.970775146182, 5851.765929362863, 5896.705164741831, 5503.889922201613, 5522.144067669517, 5525.751341189656, 5528.834134975958, 5530.253415788817, 4933.753312334369, 4970.229614409773, 5005.6996580205305, 5028.698278103326, 5070.8225212117395, 5951.1073338999495, 6010.098485227251, 6012.9098063529955, 6057.545684073712, 6064.3935606439, 5776.624519406225, 5811.186433899173, 5815.389384114607, 5825.184474173534, 5828.417158284137, 5839.036558967723, 5883.794067207627, 5948.434898684618, 6003.249593800775, 6016.187814645142, 5726.484616384545, 5731.140328950691, 5747.339056008445, 5780.0, 5836.533077353886, 5830.679312637845, 5847.561432892465, 5850.970745146417, 5852.4147585241135, 5854.531637468907, 5477.315335583052, 5700.0, 5708.5147762439, 5710.5717071219, 5711.171880077449, 5500.119980803052, 5636.154576813511, 5673.631213971079, 5684.857878553069, 5791.189233507396, 5611.382747897646, 5645.858853528694, 5647.435256474319, 5651.180578815966, 5660.349059858169, 5698.373178950229, 5740.856478588069, 5754.5684073695475, 5757.884842303214, 5759.078547432391, 5422.05114105038, 5437.864053398696, 5447.12845944647, 5514.172874068921, 5519.144532597454], "value": 5329.415468550936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.555153652846, 582.8921649494844, 595.4759811365997, 599.0983569727559, 600.8948434024045, 31692.68307316926, 41273.0, 42296.78851605738, 42421.36367954483, 45178.93389594936, 43337.0, 43760.562394376044, 43899.0, 43903.78048109763, 43913.34129988053, 7820.530768153929, 8484.91515084849, 8654.61054252557, 8659.134086591353, 8660.090690477504, 7800.76597702067, 10039.498025098752, 10258.07677309042, 10274.33216840903, 10529.36823790575, 10276.845847312296, 10338.689839304796, 10339.12117470016, 10339.483025848715, 10356.844647330296, 10339.689809305695, 10357.844632330522, 10380.32527885685, 10397.84403233952, 10404.271700980935, 10104.141148002429, 10166.644167454178, 10168.491575421273, 10174.59301627934, 10182.643607473703, 40432.0, 40554.18891622181, 40556.59443405558, 40802.38796418056, 40808.591914080775, 3302.9009129725905, 3305.0910999475095, 3411.4882767584813, 3479.6172421033666, 3661.6521430464063, 28720.425591488263, 30356.392872142434, 30770.38459230825, 31172.688273117205, 32017.0, 4097.569755175723, 4114.465119534471, 4180.561041090703, 4239.97880010598, 4374.5844144806515, 325071.0, 327537.0, 329929.0, 329946.0, 332114.0, 57546.71226643924, 57885.71057144687, 57983.42016579865, 58024.419755802744, 58038.0, 60878.086828697604, 60917.0, 60927.0, 60941.0, 61069.0, 15263.236838158047, 15461.613459663598, 15486.612834678997, 15510.457134000257, 15515.301811418512, 10768.0, 10992.780144397067, 11683.182177247681, 11723.4138293085, 11756.58851940178, 17334.739978900074, 18027.40301223206, 18314.17586208624, 18364.173612187482, 18526.258949641862, 6638.96680516604, 7131.372363567594, 7174.784756457315, 7199.820004499929, 7203.747868824671, 911.4394647291867, 953.1231267234161, 1004.6885465505717, 1056.1392465140887, 1095.5727266366123, 30896.53655195174, 30978.225544361572, 31305.37389252202, 31306.416625848582, 31461.898833540716, 1013.7060252526832, 1019.3883669798211, 1046.9110125639254, 1073.6886302972207, 1111.8999290063932, 15807.652895453612, 16549.0, 16981.405650802164, 17007.659846802995, 17821.10894455272, 456801.0, 457786.0, 460677.0, 461595.0, 462604.0, 55818.72090639602, 56064.71967640217, 56139.43860561424, 56313.43686563164, 56397.43602563922, 1180.1561883253514, 1191.7676053169548, 1301.7656821772362, 1315.7697402954445, 1327.8340207474066, 27551.586726198722, 31381.372372552876, 31805.36389272248, 31848.203794905312, 31950.520742188422, 48952.75523622359, 49645.75177124091, 49657.0, 49704.25443618421, 49715.50284497109, 372298.0, 373167.0, 374295.0, 376024.0, 376326.0, 24309.756902431458, 27119.72880271172, 27722.44555108927, 27796.305092372044, 28143.71856281411, 43870.0, 44264.33603496014, 44374.0, 45127.32309015433, 45640.771796140805, 37470.43794343033, 37474.25051499009, 37789.244215116094, 38101.61898380981, 39216.803915980236, 37685.2462950734, 37780.244395112495, 37839.62160378361, 37857.43213851739, 38133.80933095317, 37997.81001094977, 38406.80796595999, 38808.029799255244, 38842.805785970886, 38955.0, 31695.52456713197, 34171.0, 34345.31309373749, 34439.65560344465, 35112.47331289982, 26190.476190475703, 26461.603075954263, 26478.602820957316, 26541.469170616092, 26745.52439224921], "value": 19501.205065813243, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.1525630025739, 380.6498021819925, 383.7275534370595, 387.7266527098396, 405.2179293962653, 14339.641508962268, 17585.296588136476, 18625.53436164095, 19455.416337509898, 19632.312869049587, 17609.823901760978, 17667.91166044168, 17825.28698852044, 17918.0, 17983.100844957764, 5440.211169380437, 5745.224394706703, 5755.165501002352, 5755.798547050854, 5755.82732518023, 4178.874633760992, 4307.310830267158, 4325.935110973338, 5581.581381396411, 5677.48902598766, 6256.937430625704, 6375.617462952215, 6379.393957574023, 6383.202099737533, 6386.904196437057, 6057.606255593372, 6203.627782333075, 6236.189295391616, 6359.586626869239, 6374.808755737312, 5402.37872644643, 5402.594805389612, 5416.0792665247, 5437.8368648940595, 5456.48163424474, 21664.133434662595, 21884.23405180811, 21948.780512194833, 21985.120595176173, 22202.222922197645, 2171.4245724882917, 2465.1248806673552, 2502.436951685874, 2922.1671823530405, 2983.194537474891, 9890.456024918627, 10221.080102790784, 10330.58677652893, 10334.328268662588, 10369.222308326905, 1590.395649653136, 1624.2284914665559, 1639.631083006326, 1642.0476123848139, 1684.284179223825, 85135.0, 85177.57411212905, 85687.0, 86162.5691871543, 86343.13656863477, 10353.585856565653, 10559.260851740304, 10588.417637030037, 10771.407572583426, 11072.224944253825, 14520.273986300643, 14532.927335363256, 14546.636334091732, 14552.0, 14557.92721036388, 7241.782746517613, 7743.651535680908, 7770.53376797394, 7783.4162437817395, 7893.210678932176, 7203.605800461819, 7255.383292420098, 7255.818604534928, 7433.962830185923, 7448.547533230968, 4439.467263928284, 4476.888077798016, 4552.88617784558, 4559.338895860082, 4607.746573938399, 1924.8171423714725, 1934.1006432009183, 1954.189011560215, 1978.891160986131, 1987.8111579399933, 833.8999320081629, 929.6792606550729, 931.5435436636, 970.7767213540925, 1007.8034783217203, 18152.006558557096, 19028.619427611648, 19198.328058517884, 19423.514412139528, 19732.210711571377, 926.3376685669643, 969.4571040217501, 974.8342781727123, 989.8861630912393, 1014.2494554030112, 9798.559064842098, 10797.514111864984, 10848.250427273557, 10873.728156795985, 10893.509792059218, 432998.0, 438279.0, 453551.0, 456908.0, 459173.0, 91582.54208728914, 92033.0, 94172.52913735525, 94542.52728736312, 97250.51374743081, 919.650532797546, 937.6671281695036, 943.5093751249449, 952.3857112162616, 964.7202311329776, 16172.595685107966, 16197.190140492692, 16395.67208655844, 16651.583710407336, 17630.118494074988, 42038.57961420347, 42666.0, 42914.0, 43190.35214471848, 44496.6896633993, 52872.206916895506, 54640.726796365765, 54757.45242547523, 54809.45190548043, 56114.719426402604, 5689.687067211343, 8158.3065439438315, 8159.632816523389, 8271.421000529905, 8313.127121652382, 10511.0, 12328.0, 12579.811302830281, 12709.0, 12781.552645657357, 10751.731206719895, 10974.396408197306, 11032.448377580928, 11200.551977920792, 11709.238899471507, 10310.587576497157, 10559.366438013743, 10611.628592999208, 10614.787704245717, 10961.232713710282, 10462.47687615601, 10641.8935810644, 11283.153763467608, 11312.0, 11409.828852567383, 7995.800104997422, 8174.795630109057, 8198.467099638505, 8264.752057438287, 8294.543800091053, 8441.577921104043, 10436.53035613384, 10636.84044739314, 11136.443177841238, 11145.387003714874], "value": 8877.843265918526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.1636011132928, 1419.5315545869864, 1455.148737988277, 1564.6948844975227, 1698.8131305556387, 6708.429783468405, 7409.666565004574, 7708.421868359881, 7718.112417072039, 7889.0, 7690.461667683265, 7744.728934487294, 7747.767566973, 7759.573223472707, 7762.883556746639, 1920.8271255586994, 1969.3402710092137, 2246.618074927262, 2280.908763649452, 2288.6338185890263, 2083.0938541734317, 2134.8185404240658, 2136.3377353020537, 2137.593857167141, 2140.0262880389387, 2148.495103650641, 2163.740351157863, 2165.036558731365, 2172.7609962904066, 2173.9891300543477, 2196.3191410662666, 2205.38249290199, 2206.2388475975763, 2214.490667146565, 2216.2464761981005, 2116.0477784996815, 2132.9573408531896, 2137.5297434564527, 2137.8717276963275, 2138.155428605692, 7530.43521735872, 7572.39420846331, 7575.0, 7579.317861392446, 7588.544687318778, 4616.746078965655, 4735.242361222188, 4745.501722319142, 4748.667593268473, 4749.026449577828, 3079.288688306872, 3134.3104517006223, 3150.228194092439, 3211.951820722691, 3221.130294820409, 983.4541829284744, 1048.2766890845292, 1076.1498416251152, 1089.0470838016736, 1129.170060005895, 10322.690319290508, 10413.062824345845, 10422.583096676124, 10460.163186945027, 10475.947620261926, 4060.634542891154, 4306.698531102793, 4363.258246098171, 4393.384926110347, 4398.0, 8862.0, 8872.8669069964, 8880.289576833839, 8888.688895888612, 8891.866622000674, 4692.085043416501, 4693.530646935279, 4700.506446823103, 4703.0, 4703.318018887242, 3699.5190625218547, 4151.481064866892, 4354.804033818486, 4356.542563030899, 4361.6510679145595, 3658.5975542690285, 3673.8714145005333, 3780.2628487444686, 3794.165283637595, 3807.6763475104926, 1219.8475190601175, 1246.6883279180206, 1275.7257189704258, 1285.2609749393948, 1293.2886912198253, 898.2544488074882, 914.6752902719572, 927.3786563002805, 929.312308891429, 946.2950102173787, 5412.377576578665, 5425.159100339453, 5531.723413829292, 5545.306836645419, 5611.551075913999, 886.9113088691208, 893.0890491698431, 898.9640414383351, 903.114947351586, 910.3536489092686, 3663.9633603664156, 3722.4737857478303, 3730.515033045687, 3751.1934933989323, 3835.53973523179, 9038.322125840588, 9319.534023298944, 9400.200982916529, 9404.0, 9409.623615055458, 9395.107464790834, 9439.669611563562, 9460.290478214161, 9470.384425012353, 9474.621015159455, 7242.710291588278, 7396.482246242711, 7400.555966642019, 7413.777586672409, 7414.592197429085, 5098.821541246039, 5289.7355132242465, 5337.119375303031, 5368.355797304349, 5607.467290607386, 8495.0, 8584.957075214834, 8705.608247629, 8741.606627701642, 8751.993520745196, 8808.339374547062, 8835.514046727492, 8909.287257019552, 8972.19250267453, 8995.280377569648, 6055.485283750931, 6412.454941330039, 6536.901946470902, 6578.388294867788, 6594.604323740591, 6826.351496607815, 7169.641517924188, 7413.777586672409, 7437.8140546486775, 7554.395648348009, 6583.703733331916, 6686.5653732507235, 6713.362230588086, 6867.793966181022, 6903.1371078615175, 6629.900551491828, 6729.629870357177, 6730.899036514358, 6827.385535301847, 6870.62211578368, 6078.817635470943, 6177.166082578794, 6179.721912513858, 6186.381361863778, 6190.2571691397325, 4546.13623411564, 4643.466001409746, 4647.976760116313, 4673.7429441381055, 4741.2651039089, 4827.0, 4935.531124543163, 4940.604751619933, 5069.898602028013, 5090.516400941905], "value": 4189.002495643733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.1436720284811, 326.54610091972165, 328.8125768312062, 330.0511030786489, 332.91011426914724, 4986.227134794112, 5282.124845679786, 5317.335333083364, 5362.2224777407255, 5381.81163659272, 5253.57971362291, 5260.605454590911, 5261.973690131554, 5277.097596322017, 5302.496262855032, 4153.730007549515, 4166.6874984376145, 4167.312393455076, 4183.979080104596, 4206.686322522615, 4081.7142800004012, 4181.519125300599, 4191.098913733546, 4195.098053918407, 4197.643200327976, 4125.422440858282, 4132.731372460796, 4146.792660366985, 4147.191297696951, 4148.605882441163, 4129.421880936671, 4138.524069731974, 4143.357779544175, 4144.357624568182, 4157.293260145752, 3684.778913265213, 3690.538682664667, 3706.369197553068, 3725.3853114236117, 3730.3658378075793, 5091.898162036776, 5155.304033955405, 5166.199239117906, 5173.224016397533, 5176.705823544114, 4718.457377401574, 4718.504557021498, 4726.314684370747, 4731.0, 4750.12122757291, 5573.526250268732, 5581.274434323553, 5582.358028826697, 5600.691961942091, 5602.7758889644365, 3787.886363409102, 3932.193900250442, 3955.307821131319, 3957.9010524736823, 3969.5435024972207, 5457.072297709399, 5572.804951826707, 5680.3467601225975, 5727.570432217601, 5747.683877386742, 3951.0122469382654, 3963.672169823084, 3984.7409918355215, 4001.47980762499, 4004.4193591929006, 4039.434479172918, 4075.694322925792, 4077.9796101019306, 4080.489938757655, 4084.223997440477, 4453.710508816981, 4487.842925497657, 4661.883452913637, 4676.625869930397, 4688.812447502061, 5286.0, 5459.863503412446, 5507.807226747044, 5511.917321240185, 5514.365847927459, 1349.284879014124, 1360.605424426905, 1364.433759989613, 1367.994524024841, 1372.2726954714017, 879.366855863777, 937.9448120864027, 938.7512309238058, 951.4909523405083, 969.1519920069939, 5115.411727651293, 5198.9740051299505, 5217.426083130853, 5244.0, 5285.973570132125, 5459.317585301837, 5486.643368181056, 5502.202180683778, 5548.389677135512, 5560.360558535739, 5096.923546146737, 5168.19892916591, 5208.739563021833, 5228.503292187236, 5235.476452354734, 2939.3974235281717, 2944.7791415643483, 2947.675755666875, 2954.49773538499, 2962.674105848398, 5672.631278966854, 5719.0, 5728.455796699307, 5756.481916627524, 5761.279840019997, 5423.810166644149, 5460.726963651801, 5476.412949518072, 5493.752781124859, 5668.376478587352, 5511.338639363302, 5626.2967129108865, 5678.971605141948, 5721.942780572307, 5725.685087320321, 5358.35699716021, 5509.622594351412, 5525.778968841201, 5551.195076713934, 5576.0, 5434.728263586884, 5435.266239057677, 5436.483534064258, 5444.156155795699, 5463.207834864002, 5624.184493248375, 5666.320041595035, 5670.773169073191, 5732.936142988604, 5746.5402767779315, 3924.372100463912, 3983.402489626579, 3997.360422332413, 4012.859549915739, 4024.315866302794, 5655.293088363955, 5669.659820410789, 5674.432556744293, 5679.886402271849, 5684.403137670485, 5327.573794096385, 5500.80747173847, 5501.697406642673, 5543.501084902378, 5548.500634942875, 5455.727213639223, 5472.370677371994, 5482.506574408322, 5483.177523371526, 5490.5882058844945, 5381.73091345439, 5406.162044883049, 5406.5945054121885, 5413.9729301353245, 5415.945840541702, 5349.652272602424, 5492.697901615449, 5513.3108361454815, 5517.393086760373, 5538.224648549126, 5364.444311149723, 5397.298351214317, 5416.160495123262, 5421.376541697755, 5442.292501974718], "value": 4178.494718013911, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.2390156068412, 727.4798519058869, 767.3094215206314, 775.806048487878, 814.4014149600044, 13974.441022359106, 14801.925990370033, 14849.851501484982, 14864.0, 14930.626734331634, 13245.668858278548, 13390.59828205153, 13411.12827666201, 13412.865871341284, 13425.798613020812, 661.9702113404908, 679.7620832708562, 750.8423231121471, 770.9845803083934, 776.2392855002101, 771.3751860992614, 777.2150128370358, 777.3975169243853, 780.0444455541973, 780.0600276666603, 832.2842355574231, 834.1991687979516, 834.2408408348405, 834.486790623765, 834.7287131682198, 693.5145398221265, 706.3148745716646, 824.9133840946735, 828.1470085811624, 828.1718281718282, 602.8492876780805, 608.2518502242223, 608.7047781825811, 609.329737288983, 609.4545381883235, 15545.22273886301, 15559.0, 15684.529464116094, 15781.526554203392, 15784.605384865356, 14488.420463181461, 14511.927440362731, 14757.852421475754, 14957.551273461813, 14985.700285994219, 11651.475683594259, 11672.708182295426, 11879.703007424883, 12041.578544750892, 12390.5663301784, 3534.6995505382074, 3639.290338384016, 3647.6534729200685, 3765.7175711821724, 3767.773933563995, 84253.31322593847, 85682.57158714229, 86389.0, 86729.0, 87636.56181719115, 11499.885001150049, 11508.0, 11530.19718366168, 11541.192116551929, 11767.293962362286, 21732.0, 21883.562328753334, 21902.23342183016, 21927.890360548416, 22332.33003009912, 7684.116326622398, 7800.531968081933, 7885.487443316166, 8034.879476807852, 8041.798955026171, 4352.673549483801, 4376.081022985145, 4396.164728701537, 4421.911561768747, 4458.242098843204, 3407.0, 3485.0590340607896, 3523.224890524081, 3523.6652518010746, 3525.753197276217, 564.5455408396281, 570.7003822992962, 573.6644063223061, 581.5551103405897, 586.4721750424567, 548.3310361359136, 550.6668465578348, 567.140781715701, 569.2059576890215, 575.1746244139673, 9043.412178208395, 9122.0, 9313.767155821024, 9320.8601870972, 9449.987795218698, 562.3364429972671, 615.8429600451856, 644.6615526848349, 651.4495251512465, 655.3282885042869, 4218.388333691659, 4306.504751953503, 4329.718568293051, 4387.319965405367, 4402.735835849795, 82649.58675206585, 82912.58543707243, 83331.5833420829, 83566.58216708878, 87103.0, 61154.0, 61702.38297616966, 62225.37774622286, 62712.68643656753, 64325.78371081427, 57039.429605703415, 57645.42354576485, 58312.0, 59634.0, 59658.0, 8465.873011904703, 9431.905680943377, 9601.663941762004, 9617.182539484222, 9646.951765241129, 40091.599084009955, 40369.39445908373, 41113.0, 41848.79075604602, 42320.57679423167, 41262.38106428346, 42356.0, 48744.512554875415, 49064.509354906, 53611.0, 11783.234089784137, 11785.292882427082, 11788.823167652321, 11940.223885447418, 12418.192817466836, 13593.86406135926, 13759.518416855362, 13997.440102396198, 14220.786688199478, 14358.641033974234, 12245.571405000783, 12281.815772763595, 12775.425105870072, 13066.738665226832, 13375.402498230302, 12375.876241237473, 12550.497980080694, 12661.873381266438, 13012.739745204854, 13519.121257118255, 12007.245837365623, 12555.094697916293, 12662.303573303188, 12775.361231938552, 12849.164804287691, 9871.703848884545, 10149.188064954638, 10250.743731406475, 10310.587576497157, 10520.421376824042, 9302.581383837609, 9809.313348065567, 10346.896531034594, 11287.943560282147, 11359.432028398382], "value": 6887.7533161440615, "unit": "score"}], "name": "dromaeo_css", "value": 6935.067496873027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 112.0, 115.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 126.0, 159.0, 123.0, 123.0, 126.0, 124.0, 144.0, 132.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 74.0, 131.0, 78.0, 76.0, 75.0, 77.0, 90.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 106.0, 83.0, 83.0, 82.0, 95.0, 81.0, 82.0, 111.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 51.0, 52.0, 53.0, 53.0, 53.0, 51.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 62.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 90.0, 83.0, 87.0, 80.0, 81.0, 82.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 134.0, 155.0, 131.0, 134.0, 140.0, 128.0, 180.0, 130.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 165.0, 165.0, 166.0, 165.0, 165.0, 169.0, 166.0, 169.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 69.0, 65.0, 66.0, 65.0, 65.0, 64.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1503.7000000000003, "alertThreshold": 2.0}]} 14:18:46 INFO - Return code: 0 14:18:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:18:46 INFO - # TBPL SUCCESS # 14:18:46 INFO - Running post-action listener: _resource_record_post_action 14:18:46 INFO - [mozharness: 2016-11-29 22:18:46.757071Z] Finished run-tests step (success) 14:18:46 INFO - Running post-run listener: _resource_record_post_run 14:18:46 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8601600; Write bytes: 425517056; Read time: 3036; Write time: 499168 14:18:46 INFO - TinderboxPrint: CPU usage
13.1% 14:18:46 INFO - TinderboxPrint: I/O read bytes / time
8,601,600 / 3,036 14:18:46 INFO - TinderboxPrint: I/O write bytes / time
425,517,056 / 499,168 14:18:46 INFO - TinderboxPrint: CPU idle
8,329.1 (86.8%) 14:18:46 INFO - TinderboxPrint: CPU user
1,205.4 (12.6%) 14:18:46 INFO - TinderboxPrint: Swap in / out
0 / 0 14:18:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 98394112; Read time: 0; Write time: 120372 14:18:46 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6172672; Write bytes: 318672896; Read time: 2464; Write time: 366600 14:18:47 INFO - Running post-run listener: _upload_blobber_files 14:18:47 INFO - Blob upload gear active. 14:18:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:18:47 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 14:18:47 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'] 14:18:47 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 14:18:47 INFO - (blobuploader) - INFO - Open directory for files ... 14:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:48 INFO - (blobuploader) - INFO - Done attempting. 14:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:18:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:49 INFO - (blobuploader) - INFO - Done attempting. 14:18:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:18:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:18:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:18:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:18:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:18:53 INFO - (blobuploader) - INFO - Done attempting. 14:18:53 INFO - (blobuploader) - INFO - Iteration through files over. 14:18:53 INFO - Return code: 0 14:18:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:18:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:18:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a650f2db0849c7bcf5e7b83d905695632a0eb854819d8753b652855da1d6375dc2cb2b8136556e35a6554cd79a13bca8da1c13c7cdbc92abccf2fb832c9799cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0de67fa6c2e55bc2740322b2bff775b7d67a99b195e965f30b39026c93c693b1085daaba67d96112f985ff3284ac1aaa6a27da20bf922ee2ba4b05af2bba61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d36dc17d32849df7018774edcb61b6b90e7ea53e98b58474327621fa567c66b6471aeb5c22feffcad786d071d93f23d3b1ba1c868bfbc9fc0c2b20ca8d2c28f"} 14:18:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:18:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:18:53 INFO - Contents: 14:18:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a650f2db0849c7bcf5e7b83d905695632a0eb854819d8753b652855da1d6375dc2cb2b8136556e35a6554cd79a13bca8da1c13c7cdbc92abccf2fb832c9799cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0de67fa6c2e55bc2740322b2bff775b7d67a99b195e965f30b39026c93c693b1085daaba67d96112f985ff3284ac1aaa6a27da20bf922ee2ba4b05af2bba61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d36dc17d32849df7018774edcb61b6b90e7ea53e98b58474327621fa567c66b6471aeb5c22feffcad786d071d93f23d3b1ba1c868bfbc9fc0c2b20ca8d2c28f"} 14:18:53 INFO - Running post-run listener: copy_logs_to_upload_dir 14:18:53 INFO - Copying logs to upload dir... 14:18:53 INFO - mkdir: /builds/slave/test/build/upload/logs 14:18:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.911232 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-29 14:18:53.077105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 14:18:53.081064) ========= 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=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a650f2db0849c7bcf5e7b83d905695632a0eb854819d8753b652855da1d6375dc2cb2b8136556e35a6554cd79a13bca8da1c13c7cdbc92abccf2fb832c9799cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0de67fa6c2e55bc2740322b2bff775b7d67a99b195e965f30b39026c93c693b1085daaba67d96112f985ff3284ac1aaa6a27da20bf922ee2ba4b05af2bba61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d36dc17d32849df7018774edcb61b6b90e7ea53e98b58474327621fa567c66b6471aeb5c22feffcad786d071d93f23d3b1ba1c868bfbc9fc0c2b20ca8d2c28f"} build_url:https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/WTLNqkbZRka-P6nP37rFfQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a650f2db0849c7bcf5e7b83d905695632a0eb854819d8753b652855da1d6375dc2cb2b8136556e35a6554cd79a13bca8da1c13c7cdbc92abccf2fb832c9799cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0de67fa6c2e55bc2740322b2bff775b7d67a99b195e965f30b39026c93c693b1085daaba67d96112f985ff3284ac1aaa6a27da20bf922ee2ba4b05af2bba61b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/0d36dc17d32849df7018774edcb61b6b90e7ea53e98b58474327621fa567c66b6471aeb5c22feffcad786d071d93f23d3b1ba1c868bfbc9fc0c2b20ca8d2c28f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 14:18:53.110803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 14:18:53.111128) ========= 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=17051fcd5208b27b50bedfeb000001dd-1480452063.441984-1311382781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 14:18:53.193178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 14:18:53.193508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 14:18:53.193837) ========= ========= Total master_lag: 0.19 =========