builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1481732407.64 results: success (0) buildid: 20161214063629 builduid: 94c2c127805b42d6b229860d3204a8d3 revision: f6dc38c29bebfa137bef36c863f916155b0844ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.641852) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.642601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.643117) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.660197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.660521) ========= 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-1481727900.9260-229739750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-14 08:20:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-12-14 08:20:08 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.754890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.755225) ========= 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-1481727900.9260-229739750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019252 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.804659) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:07.805044) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6dc38c29bebfa137bef36c863f916155b0844ce --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6dc38c29bebfa137bef36c863f916155b0844ce --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-1481727900.9260-229739750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-14 08:20:08,138 truncating revision to first 12 chars 2016-12-14 08:20:08,138 Setting DEBUG logging. 2016-12-14 08:20:08,138 attempt 1/10 2016-12-14 08:20:08,138 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f6dc38c29beb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-14 08:20:08,438 unpacking tar archive at: mozilla-aurora-f6dc38c29beb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:08.428330) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:08.428644) ========= script_repo_revision: f6dc38c29bebfa137bef36c863f916155b0844ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:08.429061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:08.429336) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-14 08:20:08.438966) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-14 08:20:08.439277) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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-1481727900.9260-229739750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:20:08 INFO - MultiFileLogger online at 20161214 08:20:08 in /builds/slave/test 08:20:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:20:08 INFO - {'append_to_log': False, 08:20:08 INFO - 'base_work_dir': '/builds/slave/test', 08:20:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:20:08 INFO - 'branch': 'Mozilla-Aurora', 08:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:20:08 INFO - 'config_files': ('talos/linux_config.py',), 08:20:08 INFO - 'default_actions': ('clobber', 08:20:08 INFO - 'read-buildbot-config', 08:20:08 INFO - 'download-and-extract', 08:20:08 INFO - 'populate-webroot', 08:20:08 INFO - 'create-virtualenv', 08:20:08 INFO - 'install', 08:20:08 INFO - 'run-tests'), 08:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:20:08 INFO - 'download_minidump_stackwalk': True, 08:20:08 INFO - 'download_symbols': 'ondemand', 08:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:20:08 INFO - 'installer_path': 'installer.exe', 08:20:08 INFO - 'log_level': 'info', 08:20:08 INFO - 'log_name': 'talos', 08:20:08 INFO - 'log_to_console': True, 08:20:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:20:08 INFO - 'opt_config_files': (), 08:20:08 INFO - 'pip_index': False, 08:20:08 INFO - 'sps_profile': False, 08:20:08 INFO - 'sps_profile_interval': 0, 08:20:08 INFO - 'suite': 'dromaeojs', 08:20:08 INFO - 'system_bits': '32', 08:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:20:08 INFO - 'title': 'talos-linux64-ix-009', 08:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:20:08 INFO - 'use_talos_json': True, 08:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:20:08 INFO - 'work_dir': 'build'} 08:20:08 INFO - [mozharness: 2016-12-14 16:20:08.867908Z] Running clobber step. 08:20:08 INFO - Running pre-action listener: _resource_record_pre_action 08:20:08 INFO - Running main action method: clobber 08:20:08 INFO - rmtree: /builds/slave/test/build 08:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-14 16:20:09.841133Z] Finished clobber step (success) 08:20:09 INFO - [mozharness: 2016-12-14 16:20:09.841231Z] Running read-buildbot-config step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: read_buildbot_config 08:20:09 INFO - Using buildbot properties: 08:20:09 INFO - { 08:20:09 INFO - "project": "", 08:20:09 INFO - "product": "firefox", 08:20:09 INFO - "script_repo_revision": "production", 08:20:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:20:09 INFO - "repository": "", 08:20:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:20:09 INFO - "buildid": "20161214063629", 08:20:09 INFO - "pgo_build": "True", 08:20:09 INFO - "basedir": "/builds/slave/test", 08:20:09 INFO - "buildnumber": 670, 08:20:09 INFO - "slavename": "talos-linux64-ix-009", 08:20:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:20:09 INFO - "platform": "ubuntu64_hw", 08:20:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:20:09 INFO - "branch": "mozilla-aurora", 08:20:09 INFO - "repo_path": "releases/mozilla-aurora", 08:20:09 INFO - "revision": "f6dc38c29bebfa137bef36c863f916155b0844ce", 08:20:09 INFO - "stage_platform": "linux64-pgo", 08:20:09 INFO - "builduid": "94c2c127805b42d6b229860d3204a8d3", 08:20:09 INFO - "slavebuilddir": "test" 08:20:09 INFO - } 08:20:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:20:09 INFO - Running post-action listener: _resource_record_post_action 08:20:09 INFO - [mozharness: 2016-12-14 16:20:09.843639Z] Finished read-buildbot-config step (success) 08:20:09 INFO - [mozharness: 2016-12-14 16:20:09.843728Z] Running download-and-extract step. 08:20:09 INFO - Running pre-action listener: _resource_record_pre_action 08:20:09 INFO - Running main action method: download_and_extract 08:20:09 INFO - mkdir: /builds/slave/test/build/tests 08:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:09 INFO - trying https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:20:09 INFO - Downloading https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:20:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:20:10 INFO - Downloaded 1361 bytes. 08:20:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:20:10 INFO - Using the following test package requirements: 08:20:10 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:20:10 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:20:10 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:20:10 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'jsshell-linux-x86_64.zip'], 08:20:10 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:20:10 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:20:10 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:20:10 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:20:10 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:20:10 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:20:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:20:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:20:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:20:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:10 INFO - Fetch https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:20:10 INFO - Http code: 200 08:20:10 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 08:20:10 INFO - x-amz-cf-id: u5DtUyyP1BxjmvYajXyecMrHrF7rc2B3gaqmOl10YARrPvb-toMzRg== 08:20:10 INFO - x-amz-version-id: oF3Nlr9BXZotIB_Yj0fhXtNEvSNynhpn 08:20:11 INFO - Expected file size: 21954180 08:20:11 INFO - Obtained file size: 21954180 08:20:15 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:20:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:20:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:20:15 INFO - Fetch https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:20:15 INFO - Http code: 200 08:20:15 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:20:15 INFO - x-amz-cf-id: A2IDl3dgnbykV4U6blIgSdgKKUmWfNRQtYhtjMIxnuRQKAkcehyP9Q== 08:20:15 INFO - x-amz-version-id: oF3Nlr9BXZotIB_Yj0fhXtNEvSNynhpn 08:20:16 INFO - Expected file size: 21954180 08:20:16 INFO - Obtained file size: 21954180 08:20:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:20:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:20:20 INFO - Fetch https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:20:21 INFO - Http code: 200 08:20:21 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:20:21 INFO - x-amz-cf-id: CyQVWHL6ukTMT1IP5XM6s6LsKl5BR37iRM5lqKWQhyiyZMx5kjRwAg== 08:20:21 INFO - x-amz-version-id: 1oxIxFrMfn6ZatJDTA9_rOfN.HP9Jxr0 08:20:21 INFO - Expected file size: 14409038 08:20:21 INFO - Obtained file size: 14409038 08:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:21 INFO - trying https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:20:21 INFO - Downloading https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:20:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:20:23 INFO - Downloaded 64014417 bytes. 08:20:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:20:23 INFO - mkdir: /builds/slave/test/properties 08:20:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:20:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:20:23 INFO - Contents: 08:20:23 INFO - build_url:https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:20:24 INFO - Running post-action listener: _resource_record_post_action 08:20:24 INFO - Running post-action listener: set_extra_try_arguments 08:20:24 INFO - [mozharness: 2016-12-14 16:20:24.190197Z] Finished download-and-extract step (success) 08:20:24 INFO - [mozharness: 2016-12-14 16:20:24.190422Z] Running populate-webroot step. 08:20:24 INFO - Running pre-action listener: _resource_record_pre_action 08:20:24 INFO - Running main action method: populate_webroot 08:20:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:20:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:20:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:20:24 INFO - '--tppagecycles', 08:20:24 INFO - '7'], 08:20:24 INFO - 'tests': ['tsvgm']}}, 08:20:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:20:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:20:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:20:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:20:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:20:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['damp', 'tps']}, 08:20:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'tests': ['damp', 'tps']}, 08:20:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['dromaeo_dom']}, 08:20:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:20:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['basic_compositor_video']}, 08:20:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:20:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['a11yr', 08:20:24 INFO - 'ts_paint', 08:20:24 INFO - 'tpaint', 08:20:24 INFO - 'sessionrestore', 08:20:24 INFO - 'sessionrestore_no_auto_restore', 08:20:24 INFO - 'tabpaint']}, 08:20:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['tsvgx', 08:20:24 INFO - 'tsvgr_opacity', 08:20:24 INFO - 'tart', 08:20:24 INFO - 'tscrollx', 08:20:24 INFO - 'cart']}, 08:20:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:20:24 INFO - 'tsvgr_opacity', 08:20:24 INFO - 'tart', 08:20:24 INFO - 'tscrollx', 08:20:24 INFO - 'cart']}, 08:20:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'talos_options': ['--disable-e10s'], 08:20:24 INFO - 'tests': ['tp5o']}, 08:20:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'tests': ['tp5o']}, 08:20:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'talos_options': ['--disable-e10s', 08:20:24 INFO - '--xperf_path', 08:20:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:24 INFO - 'tests': ['tp5n']}, 08:20:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:20:24 INFO - 'talos_options': ['--xperf_path', 08:20:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:20:24 INFO - 'tests': ['tp5n']}}, 08:20:24 INFO - 'talos.zip': {'path': '', 08:20:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:20:24 INFO - Running post-action listener: _resource_record_post_action 08:20:24 INFO - [mozharness: 2016-12-14 16:20:24.210395Z] Finished populate-webroot step (success) 08:20:24 INFO - [mozharness: 2016-12-14 16:20:24.210483Z] Running create-virtualenv step. 08:20:24 INFO - Running pre-action listener: _resource_record_pre_action 08:20:24 INFO - Running main action method: create_virtualenv 08:20:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:20:24 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 08:20:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:20:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:20:24 INFO - Using real prefix '/usr' 08:20:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:20:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:20:26 INFO - Installing pip.................done. 08:20:26 INFO - Return code: 0 08:20:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:20:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:20:26 INFO - Reading from file tmpfile_stdout 08:20:26 INFO - Output received: 08:20:26 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) 08:20:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:20:26 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')]} 08:20:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:26 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')]} 08:20:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:26 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:26 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 08:20:26 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 08:20:26 INFO - Using env: {'DISPLAY': ':0', 08:20:26 INFO - 'HOME': '/home/cltbld', 08:20:26 INFO - 'LANG': 'en_US.UTF-8', 08:20:26 INFO - 'LANGUAGE': 'en_US:en', 08:20:26 INFO - 'LOGNAME': 'cltbld', 08:20:26 INFO - 'MAIL': '/var/mail/cltbld', 08:20:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:26 INFO - 'MOZ_NO_REMOTE': '1', 08:20:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:26 INFO - 'NO_EM_RESTART': '1', 08:20:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:26 INFO - 'PWD': '/builds/slave/test', 08:20:26 INFO - 'SHELL': '/bin/bash', 08:20:26 INFO - 'SHLVL': '1', 08:20:26 INFO - 'TERM': 'linux', 08:20:26 INFO - 'TMOUT': '86400', 08:20:26 INFO - 'USER': 'cltbld', 08:20:26 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:26 INFO - '_': '/tools/buildbot/bin/python'} 08:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:27 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 08:20:27 INFO - Cleaning up... 08:20:27 INFO - Return code: 0 08:20:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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', '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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:20: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 psutil>=3.1.1 08:20:27 INFO - Using env: {'DISPLAY': ':0', 08:20:27 INFO - 'HOME': '/home/cltbld', 08:20:27 INFO - 'LANG': 'en_US.UTF-8', 08:20:27 INFO - 'LANGUAGE': 'en_US:en', 08:20:27 INFO - 'LOGNAME': 'cltbld', 08:20:27 INFO - 'MAIL': '/var/mail/cltbld', 08:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:27 INFO - 'MOZ_NO_REMOTE': '1', 08:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:27 INFO - 'NO_EM_RESTART': '1', 08:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:27 INFO - 'PWD': '/builds/slave/test', 08:20:27 INFO - 'SHELL': '/bin/bash', 08:20:27 INFO - 'SHLVL': '1', 08:20:27 INFO - 'TERM': 'linux', 08:20:27 INFO - 'TMOUT': '86400', 08:20:27 INFO - 'USER': 'cltbld', 08:20:27 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:27 INFO - '_': '/tools/buildbot/bin/python'} 08:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:27 INFO - Downloading/unpacking psutil>=3.1.1 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:20:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:29 INFO - Installing collected packages: psutil 08:20:29 INFO - Running setup.py install for psutil 08:20:29 INFO - building 'psutil._psutil_linux' extension 08:20:29 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 08:20:29 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 08:20:29 INFO - building 'psutil._psutil_posix' extension 08:20:29 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 08:20:29 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 08:20:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:20:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:20:29 INFO - Successfully installed psutil 08:20:30 INFO - Cleaning up... 08:20:30 INFO - Return code: 0 08:20:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:30 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:30 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 08:20:30 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 08:20:30 INFO - Using env: {'DISPLAY': ':0', 08:20:30 INFO - 'HOME': '/home/cltbld', 08:20:30 INFO - 'LANG': 'en_US.UTF-8', 08:20:30 INFO - 'LANGUAGE': 'en_US:en', 08:20:30 INFO - 'LOGNAME': 'cltbld', 08:20:30 INFO - 'MAIL': '/var/mail/cltbld', 08:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:30 INFO - 'MOZ_NO_REMOTE': '1', 08:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:30 INFO - 'NO_EM_RESTART': '1', 08:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:30 INFO - 'PWD': '/builds/slave/test', 08:20:30 INFO - 'SHELL': '/bin/bash', 08:20:30 INFO - 'SHLVL': '1', 08:20:30 INFO - 'TERM': 'linux', 08:20:30 INFO - 'TMOUT': '86400', 08:20:30 INFO - 'USER': 'cltbld', 08:20:30 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:30 INFO - '_': '/tools/buildbot/bin/python'} 08:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:20:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:20:32 INFO - Installing collected packages: mozsystemmonitor 08:20:32 INFO - Running setup.py install for mozsystemmonitor 08:20:32 INFO - Successfully installed mozsystemmonitor 08:20:32 INFO - Cleaning up... 08:20:32 INFO - Return code: 0 08:20:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:20: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')]} 08:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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')]} 08:20:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20: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', '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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:20: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 jsonschema==2.5.1 08:20:32 INFO - Using env: {'DISPLAY': ':0', 08:20:32 INFO - 'HOME': '/home/cltbld', 08:20:32 INFO - 'LANG': 'en_US.UTF-8', 08:20:32 INFO - 'LANGUAGE': 'en_US:en', 08:20:32 INFO - 'LOGNAME': 'cltbld', 08:20:32 INFO - 'MAIL': '/var/mail/cltbld', 08:20:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:32 INFO - 'MOZ_NO_REMOTE': '1', 08:20:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:32 INFO - 'NO_EM_RESTART': '1', 08:20:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:32 INFO - 'PWD': '/builds/slave/test', 08:20:32 INFO - 'SHELL': '/bin/bash', 08:20:32 INFO - 'SHLVL': '1', 08:20:32 INFO - 'TERM': 'linux', 08:20:32 INFO - 'TMOUT': '86400', 08:20:32 INFO - 'USER': 'cltbld', 08:20:32 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:32 INFO - '_': '/tools/buildbot/bin/python'} 08:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:20:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:20:34 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 08:20:34 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 08:20:34 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 08:20:34 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 08:20:34 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 08:20:34 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 08:20:34 INFO - Downloading functools32-3.2.3-2.tar.gz 08:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:20:34 INFO - warning: no files found matching '*.txt' 08:20:34 INFO - no previously-included directories found matching 'build' 08:20:34 INFO - no previously-included directories found matching 'dist' 08:20:34 INFO - no previously-included directories found matching '.git*' 08:20:34 INFO - Installing collected packages: jsonschema, functools32 08:20:34 INFO - Running setup.py install for functools32 08:20:35 INFO - warning: no files found matching '*.txt' 08:20:35 INFO - no previously-included directories found matching 'build' 08:20:35 INFO - no previously-included directories found matching 'dist' 08:20:35 INFO - no previously-included directories found matching '.git*' 08:20:35 INFO - Successfully installed jsonschema functools32 08:20:35 INFO - Cleaning up... 08:20:35 INFO - Return code: 0 08:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:20:35 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')]} 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:35 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')]} 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:35 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:35 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 08:20:35 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 08:20:35 INFO - Using env: {'DISPLAY': ':0', 08:20:35 INFO - 'HOME': '/home/cltbld', 08:20:35 INFO - 'LANG': 'en_US.UTF-8', 08:20:35 INFO - 'LANGUAGE': 'en_US:en', 08:20:35 INFO - 'LOGNAME': 'cltbld', 08:20:35 INFO - 'MAIL': '/var/mail/cltbld', 08:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:35 INFO - 'MOZ_NO_REMOTE': '1', 08:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:35 INFO - 'NO_EM_RESTART': '1', 08:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:35 INFO - 'PWD': '/builds/slave/test', 08:20:35 INFO - 'SHELL': '/bin/bash', 08:20:35 INFO - 'SHLVL': '1', 08:20:35 INFO - 'TERM': 'linux', 08:20:35 INFO - 'TMOUT': '86400', 08:20:35 INFO - 'USER': 'cltbld', 08:20:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:35 INFO - '_': '/tools/buildbot/bin/python'} 08:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:20:35 INFO - Cleaning up... 08:20:35 INFO - Return code: 0 08:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:20:35 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')]} 08:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:35 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')]} 08:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:35 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:35 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 08:20:35 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 08:20:35 INFO - Using env: {'DISPLAY': ':0', 08:20:35 INFO - 'HOME': '/home/cltbld', 08:20:35 INFO - 'LANG': 'en_US.UTF-8', 08:20:35 INFO - 'LANGUAGE': 'en_US:en', 08:20:35 INFO - 'LOGNAME': 'cltbld', 08:20:35 INFO - 'MAIL': '/var/mail/cltbld', 08:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:35 INFO - 'MOZ_NO_REMOTE': '1', 08:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:35 INFO - 'NO_EM_RESTART': '1', 08:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:35 INFO - 'PWD': '/builds/slave/test', 08:20:35 INFO - 'SHELL': '/bin/bash', 08:20:35 INFO - 'SHLVL': '1', 08:20:35 INFO - 'TERM': 'linux', 08:20:35 INFO - 'TMOUT': '86400', 08:20:35 INFO - 'USER': 'cltbld', 08:20:35 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:35 INFO - '_': '/tools/buildbot/bin/python'} 08:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20: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 08:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:20:37 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 08:20:37 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 08:20:37 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 08:20:37 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 08:20:37 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 08:20:37 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 08:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:20:38 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 08:20:38 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 08:20:38 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 08:20:38 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 08:20:38 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 08:20:38 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 08:20:38 INFO - Downloading docopt-0.6.1.tar.gz 08:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:20:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:20:38 INFO - Running setup.py install for blobuploader 08:20:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:20:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:20:38 INFO - Running setup.py install for requests 08:20:38 INFO - Running setup.py install for docopt 08:20:38 INFO - Successfully installed blobuploader requests docopt 08:20:38 INFO - Cleaning up... 08:20:38 INFO - Return code: 0 08:20:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:38 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')]} 08:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:38 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')]} 08:20:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:38 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:38 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 08:20:38 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 08:20:38 INFO - Using env: {'DISPLAY': ':0', 08:20:38 INFO - 'HOME': '/home/cltbld', 08:20:38 INFO - 'LANG': 'en_US.UTF-8', 08:20:38 INFO - 'LANGUAGE': 'en_US:en', 08:20:38 INFO - 'LOGNAME': 'cltbld', 08:20:38 INFO - 'MAIL': '/var/mail/cltbld', 08:20:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:38 INFO - 'MOZ_NO_REMOTE': '1', 08:20:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:38 INFO - 'NO_EM_RESTART': '1', 08:20:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:38 INFO - 'PWD': '/builds/slave/test', 08:20:38 INFO - 'SHELL': '/bin/bash', 08:20:38 INFO - 'SHLVL': '1', 08:20:38 INFO - 'TERM': 'linux', 08:20:38 INFO - 'TMOUT': '86400', 08:20:38 INFO - 'USER': 'cltbld', 08:20:38 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:38 INFO - '_': '/tools/buildbot/bin/python'} 08:20:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:39 INFO - Running setup.py (path:/tmp/pip-nWn4AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:39 INFO - Running setup.py (path:/tmp/pip-NWd377-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:39 INFO - Running setup.py (path:/tmp/pip-_3nu2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:39 INFO - Running setup.py (path:/tmp/pip-FXn3D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:39 INFO - Running setup.py (path:/tmp/pip-Q6OmQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:39 INFO - Running setup.py (path:/tmp/pip-3XIc4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:39 INFO - Running setup.py (path:/tmp/pip-eJ1eem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:39 INFO - Running setup.py (path:/tmp/pip-AaDuLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:39 INFO - Running setup.py (path:/tmp/pip-sbXiRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:39 INFO - Running setup.py (path:/tmp/pip-iVPQbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:39 INFO - Running setup.py (path:/tmp/pip-VRs2gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:39 INFO - Running setup.py (path:/tmp/pip-S9khwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:40 INFO - Running setup.py (path:/tmp/pip-xVrN6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:40 INFO - Running setup.py (path:/tmp/pip-lcawtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:40 INFO - Running setup.py (path:/tmp/pip-DYWGxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:40 INFO - Running setup.py (path:/tmp/pip-icqstc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:40 INFO - Running setup.py (path:/tmp/pip-nzWEuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:20:40 INFO - Running setup.py install for manifestparser 08:20:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozcrash 08:20:40 INFO - Running setup.py install for mozdebug 08:20:40 INFO - Running setup.py install for mozdevice 08:20:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozfile 08:20:40 INFO - Running setup.py install for mozhttpd 08:20:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:20:40 INFO - Running setup.py install for mozinfo 08:20:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for mozInstall 08:20:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for mozleak 08:20:41 INFO - Running setup.py install for mozlog 08:20:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for moznetwork 08:20:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for mozprocess 08:20:41 INFO - Running setup.py install for mozprofile 08:20:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for mozrunner 08:20:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:20:41 INFO - Running setup.py install for mozscreenshot 08:20:41 INFO - Running setup.py install for moztest 08:20:42 INFO - Running setup.py install for mozversion 08:20:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:20:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:20:42 INFO - Cleaning up... 08:20:42 INFO - Return code: 0 08:20:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:42 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:42 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 08:20:42 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 08:20:42 INFO - Using env: {'DISPLAY': ':0', 08:20:42 INFO - 'HOME': '/home/cltbld', 08:20:42 INFO - 'LANG': 'en_US.UTF-8', 08:20:42 INFO - 'LANGUAGE': 'en_US:en', 08:20:42 INFO - 'LOGNAME': 'cltbld', 08:20:42 INFO - 'MAIL': '/var/mail/cltbld', 08:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:42 INFO - 'MOZ_NO_REMOTE': '1', 08:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:42 INFO - 'NO_EM_RESTART': '1', 08:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:42 INFO - 'PWD': '/builds/slave/test', 08:20:42 INFO - 'SHELL': '/bin/bash', 08:20:42 INFO - 'SHLVL': '1', 08:20:42 INFO - 'TERM': 'linux', 08:20:42 INFO - 'TMOUT': '86400', 08:20:42 INFO - 'USER': 'cltbld', 08:20:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:42 INFO - '_': '/tools/buildbot/bin/python'} 08:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:20:42 INFO - Running setup.py (path:/tmp/pip-QtvE5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:20:42 INFO - Running setup.py (path:/tmp/pip-p82a0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:20:42 INFO - Running setup.py (path:/tmp/pip-dU0uHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:20:42 INFO - Running setup.py (path:/tmp/pip-feDsPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:20:42 INFO - Running setup.py (path:/tmp/pip-3rO7Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:20:42 INFO - Running setup.py (path:/tmp/pip-xgPt4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:20:42 INFO - Running setup.py (path:/tmp/pip-IK55s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:20:42 INFO - Running setup.py (path:/tmp/pip-ZEQ1rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:20:42 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)) 08:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:20:42 INFO - Running setup.py (path:/tmp/pip-QW10oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:20:43 INFO - Running setup.py (path:/tmp/pip-pAvE9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:20:43 INFO - Running setup.py (path:/tmp/pip-u0TYIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:20:43 INFO - Running setup.py (path:/tmp/pip-bCrxWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:20:43 INFO - Running setup.py (path:/tmp/pip-3zylqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:20:43 INFO - Running setup.py (path:/tmp/pip-E2Czg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:43 INFO - Running setup.py (path:/tmp/pip-Z084p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:20:43 INFO - Running setup.py (path:/tmp/pip-q7m7SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:20:43 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)) 08:20:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:20:43 INFO - Running setup.py (path:/tmp/pip-rBlezB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:20:43 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)) 08:20:43 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)) 08:20:43 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)) 08:20:43 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)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:20:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:20:43 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 08:20:43 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 08:20:43 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 08:20:43 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 08:20:43 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 08:20:43 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 08:20:45 INFO - Downloading blessings-1.6.tar.gz 08:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:20:45 INFO - Installing collected packages: blessings 08:20:45 INFO - Running setup.py install for blessings 08:20:45 INFO - Successfully installed blessings 08:20:45 INFO - Cleaning up... 08:20:45 INFO - Return code: 0 08:20:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:20:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:46 INFO - Reading from file tmpfile_stdout 08:20:46 INFO - Current package versions: 08:20:46 INFO - argparse == 1.2.1 08:20:46 INFO - blessings == 1.6 08:20:46 INFO - blobuploader == 1.2.4 08:20:46 INFO - docopt == 0.6.1 08:20:46 INFO - functools32 == 3.2.3-2 08:20:46 INFO - jsonschema == 2.5.1 08:20:46 INFO - manifestparser == 1.1 08:20:46 INFO - mozInstall == 1.12 08:20:46 INFO - mozcrash == 1.0 08:20:46 INFO - mozdebug == 0.1 08:20:46 INFO - mozdevice == 0.48 08:20:46 INFO - mozfile == 1.2 08:20:46 INFO - mozhttpd == 0.7 08:20:46 INFO - mozinfo == 0.9 08:20:46 INFO - mozleak == 0.1 08:20:46 INFO - mozlog == 3.4 08:20:46 INFO - moznetwork == 0.27 08:20:46 INFO - mozprocess == 0.23 08:20:46 INFO - mozprofile == 0.28 08:20:46 INFO - mozrunner == 6.13 08:20:46 INFO - mozscreenshot == 0.1 08:20:46 INFO - mozsystemmonitor == 0.3 08:20:46 INFO - moztest == 0.7 08:20:46 INFO - mozversion == 1.4 08:20:46 INFO - psutil == 3.1.1 08:20:46 INFO - requests == 1.2.3 08:20:46 INFO - wsgiref == 0.1.2 08:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:20:46 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')]} 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 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')]} 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:46 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 08:20:46 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 08:20:46 INFO - Using env: {'DISPLAY': ':0', 08:20:46 INFO - 'HOME': '/home/cltbld', 08:20:46 INFO - 'LANG': 'en_US.UTF-8', 08:20:46 INFO - 'LANGUAGE': 'en_US:en', 08:20:46 INFO - 'LOGNAME': 'cltbld', 08:20:46 INFO - 'MAIL': '/var/mail/cltbld', 08:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:46 INFO - 'MOZ_NO_REMOTE': '1', 08:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:46 INFO - 'NO_EM_RESTART': '1', 08:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:46 INFO - 'PWD': '/builds/slave/test', 08:20:46 INFO - 'SHELL': '/bin/bash', 08:20:46 INFO - 'SHLVL': '1', 08:20:46 INFO - 'TERM': 'linux', 08:20:46 INFO - 'TMOUT': '86400', 08:20:46 INFO - 'USER': 'cltbld', 08:20:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:46 INFO - '_': '/tools/buildbot/bin/python'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 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)) 08:20:46 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:20:46 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')]} 08:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 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')]} 08:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:20:46 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 0x7f61bf127f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd49ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, '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-1481727900.9260-229739750', '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 08:20:46 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 08:20:46 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 08:20:46 INFO - Using env: {'DISPLAY': ':0', 08:20:46 INFO - 'HOME': '/home/cltbld', 08:20:46 INFO - 'LANG': 'en_US.UTF-8', 08:20:46 INFO - 'LANGUAGE': 'en_US:en', 08:20:46 INFO - 'LOGNAME': 'cltbld', 08:20:46 INFO - 'MAIL': '/var/mail/cltbld', 08:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:20:46 INFO - 'MOZ_NO_REMOTE': '1', 08:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:20:46 INFO - 'NO_EM_RESTART': '1', 08:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:20:46 INFO - 'PWD': '/builds/slave/test', 08:20:46 INFO - 'SHELL': '/bin/bash', 08:20:46 INFO - 'SHLVL': '1', 08:20:46 INFO - 'TERM': 'linux', 08:20:46 INFO - 'TMOUT': '86400', 08:20:46 INFO - 'USER': 'cltbld', 08:20:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:20:46 INFO - '_': '/tools/buildbot/bin/python'} 08:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:20:46 INFO - Cleaning up... 08:20:46 INFO - Return code: 0 08:20:46 INFO - Running post-action listener: _resource_record_post_action 08:20:46 INFO - Running post-action listener: _start_resource_monitoring 08:20:46 INFO - Starting resource monitoring. 08:20:46 INFO - [mozharness: 2016-12-14 16:20:46.560626Z] Finished create-virtualenv step (success) 08:20:46 INFO - [mozharness: 2016-12-14 16:20:46.561192Z] Running install step. 08:20:46 INFO - Running pre-action listener: _resource_record_pre_action 08:20:46 INFO - Running main action method: install 08:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:20:46 INFO - Reading from file tmpfile_stdout 08:20:46 INFO - Detecting whether we're running mozinstall >=1.0... 08:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:20:46 INFO - Reading from file tmpfile_stdout 08:20:46 INFO - Output received: 08:20:46 INFO - Usage: mozinstall [options] installer 08:20:46 INFO - Options: 08:20:46 INFO - -h, --help show this help message and exit 08:20:46 INFO - -d DEST, --destination=DEST 08:20:46 INFO - Directory to install application into. [default: 08:20:46 INFO - "/builds/slave/test"] 08:20:46 INFO - --app=APP Application being installed. [default: firefox] 08:20:46 INFO - mkdir: /builds/slave/test/build/application 08:20:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:21:02 INFO - Reading from file tmpfile_stdout 08:21:02 INFO - Output received: 08:21:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:21:02 INFO - Running post-action listener: _resource_record_post_action 08:21:02 INFO - [mozharness: 2016-12-14 16:21:02.785869Z] Finished install step (success) 08:21:02 INFO - [mozharness: 2016-12-14 16:21:02.786108Z] Running run-tests step. 08:21:02 INFO - Running pre-action listener: _resource_record_pre_action 08:21:02 INFO - Running main action method: run_tests 08:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:21:02 INFO - Python 2.7.3 08:21:02 INFO - Return code: 0 08:21:02 INFO - grabbing minidump binary from tooltool 08:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:21:02 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 0xd46f60>, '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 0xd47d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd481d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:21:02 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 08:21:02 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 08:21:02 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 08:21:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:21:02 INFO - Return code: 0 08:21:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:21:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:21:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:21:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:21:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.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 08:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.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 08:21:02 INFO - Using env: {'DISPLAY': ':0', 08:21:02 INFO - 'HOME': '/home/cltbld', 08:21:02 INFO - 'LANG': 'en_US.UTF-8', 08:21:02 INFO - 'LANGUAGE': 'en_US:en', 08:21:02 INFO - 'LOGNAME': 'cltbld', 08:21:02 INFO - 'MAIL': '/var/mail/cltbld', 08:21:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:21:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:02 INFO - 'MOZ_NO_REMOTE': '1', 08:21:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:02 INFO - 'NO_EM_RESTART': '1', 08:21:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:02 INFO - 'PWD': '/builds/slave/test', 08:21:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:21:02 INFO - 'SHELL': '/bin/bash', 08:21:02 INFO - 'SHLVL': '1', 08:21:02 INFO - 'TERM': 'linux', 08:21:02 INFO - 'TMOUT': '86400', 08:21:02 INFO - 'USER': 'cltbld', 08:21:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1481727900.9260-229739750', 08:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:02 INFO - '_': '/tools/buildbot/bin/python'} 08:21:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.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 08:21:03 INFO - mozversion application_buildid: 20161214063629 08:21:03 INFO - mozversion application_changeset: f6dc38c29bebfa137bef36c863f916155b0844ce 08:21:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:21:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:21:03 INFO - mozversion application_name: Firefox 08:21:03 INFO - mozversion application_remotingname: firefox-dev 08:21:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:03 INFO - mozversion application_vendor: Mozilla 08:21:03 INFO - mozversion application_version: 52.0a2 08:21:03 INFO - mozversion platform_buildid: 20161214063629 08:21:03 INFO - mozversion platform_changeset: f6dc38c29bebfa137bef36c863f916155b0844ce 08:21:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:21:03 INFO - mozversion platform_version: 52.0a2 08:21:03 INFO - using testdate: 1481732463 08:21:03 INFO - actual date: 1481732463 08:21:03 INFO - starting webserver on 'localhost:42581' 08:21:03 INFO - SUITE-START | Running 2 tests 08:21:03 INFO - TEST-START | dromaeo_css 08:21:03 INFO - operating with platform_type : linux_ 08:21:03 INFO - Initialising browser for dromaeo_css test... 08:21:03 INFO - TEST-INFO | started process 22629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPptmNC/profile http://localhost:42581/getInfo.html) 08:21:07 INFO - PROCESS | 22629 | __metrics Screen width/height:1600/1200 08:21:07 INFO - PROCESS | 22629 | colorDepth:24 08:21:07 INFO - PROCESS | 22629 | Browser inner width/height: 1024/697 08:21:07 INFO - PROCESS | 22629 | __metrics 08:21:07 INFO - PROCESS | 22629 | 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" 08:21:07 INFO - PROCESS | 22629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:21:08 INFO - PROCESS | 22629 | console.error: PushService: 08:21:08 INFO - PROCESS | 22629 | stateChangeProcessEnqueue: Error transitioning state 08:21:08 INFO - PROCESS | 22629 | UnknownError 08:21:08 INFO - TEST-INFO | 22629: exit 0 08:21:08 INFO - Browser initialized. 08:21:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:21:08 INFO - TEST-INFO | started process 22723 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPptmNC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:21:20 INFO - PROCESS | 22723 | RSS: Main: 144547840 08:21:20 INFO - PROCESS | 22723 | 08:22:12 INFO - PROCESS | 22723 | 1481732532078 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] 08:24:22 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42581/tests/dromaeo/cssquery-ext.html) 08:24:23 INFO - PROCESS | 22723 | RSS: Main: 262189056 08:24:23 INFO - PROCESS | 22723 | 08:27:25 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-ext.html (next: http://localhost:42581/tests/dromaeo/cssquery-jquery.html) 08:27:26 INFO - PROCESS | 22723 | RSS: Main: 227278848 08:27:26 INFO - PROCESS | 22723 | 08:30:28 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42581/tests/dromaeo/cssquery-mootools.html) 08:30:28 INFO - PROCESS | 22723 | RSS: Main: 174469120 08:30:28 INFO - PROCESS | 22723 | 08:33:30 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42581/tests/dromaeo/cssquery-prototype.html) 08:33:31 INFO - PROCESS | 22723 | RSS: Main: 218488832 08:33:31 INFO - PROCESS | 22723 | 08:36:34 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42581/tests/dromaeo/cssquery-yui.html) 08:36:34 INFO - PROCESS | 22723 | RSS: Main: 174342144 08:36:34 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | Cycle 1(1): loaded http://localhost:42581/tests/dromaeo/cssquery-yui.html (next: http://localhost:42581/tests/dromaeo/cssquery-dojo.html) 08:39:37 INFO - PROCESS | 22723 | RSS: Main: 257699840 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | __start_tp_report 08:39:37 INFO - PROCESS | 22723 | _x_x_mozilla_page_load 08:39:37 INFO - PROCESS | 22723 | _x_x_mozilla_page_load_details 08:39:37 INFO - PROCESS | 22723 | |i|pagename|runs| 08:39:37 INFO - PROCESS | 22723 | |0;dojo.html;3145.669704681008;3192.64880863105;3211.8875839345615;3238.2713889374877;3249.756268279878;5452.9727351363235;5513.586481013925;5520.337559492857;5521.503064724174;5527.088030474972;5568.681908777118;5618.325800903897;5621;5628.183913332575;5645.717714114288;5058.671186372892;5076.796928122889;5097.745112744366;5149.510796474329;5174.715390653512;5014.949850501503;5022.5730812880765;5119.846404607849;5171.3535808024;5182.6631268967585;4973.129702302101;5005.29925810385;5020.548150666439;5028.647994640377;5039.874003149914;5047.64666473347;5055.823046193403;5109.795608175668;5119.948800511985;5148.665336753136;4860.538248866352;4991.650584459089;5009.198528235464;5051.747412629391;5076;5347;5388.0570900092325;5425.864353391197;5451.700156491392;5529.972350138264;5800.303963524404;5811.88376232473;5906.940930590682;5910.468057874769;5913.763449462016;5844.678542680151;5935.050391937312;5953.1070339449;5961.403859614047;5969.283685957669;5518.448155184489;5546.084895992157;5600.019996500596;5605.635633683797;5616.410276920946;6148;6152.046432802923;6152.477039451607;6155.199824022849;6156.29202641693;5757;5843.970780146072;5887.4406931341455;5908.586398952118;5914.704264786744;5850.034744267234;5884.529237660977;5895.20414744004;5896.174535565025;5980.372060933626;5895.174675545427;5914.852128696817;5918.437748413894;5922.733476993546;5924.851878702981;5820.650760954271;5835.037218858925;5867.853303667443;5878.794242201502;5890.852728681732;4460.910781784346;4465.441819772528;4517.457905051415;4581.679282450264;4595.1039547287955;4087.2642924273323;4104.302268614343;4106;4133.586641335843;4139.296319625671;5591.3569939456665;5598;5599.076152434803;5621.747021384048;5630.60585758993;5769.509591684754;5827.446392592697;5913.2608423947;5963.761449542057;5974;5653.349864765522;5660.15097735343;5661.405552417019;5669.716514174274;5688.089905615165;5152.5362717354865;5165.199394093921;5166.095933211673;5168.948310516922;5193.298904647824;6040.607360521552;6112.908306375319;6176.50575995538;6225.782097626561;6229.844253893598;5897.233359663388;5924.4667979882015;5971.880562388815;5972.074328479092;5975.40245975399;6154.784582539769;6155.199824022849;6158.076288556752;6164.568480206342;6165.10605962124;5823.4467725566;5851.882962340645;5880.676562789087;5894.174815525916;5944.940550594439;5989.790357337647;5992.940070599238;6001.669908155093;6008.309044459768;6009.639421634716;5853.765849366148;5867.266591676041;5868.413158684098;5869.941300586939;5870.706464676835;5668.7732490701555;5723.084306510938;5743.253377061123;5756.16535602327;5781.595288329945;5769.9711501442225;5825.825225243249;5826.067829147316;5832.24180856486;5845.853853653693;5831.912521312269;5861.9413805861395;5864.091065884794;5866.67733274674;5868.38381969887;5579.944200557942;5619.494245517923;5670.659760414388;5685.800996965087;5700.2304688868135 08:39:37 INFO - PROCESS | 22723 | |1;ext.html;583.9883202335953;620.1813606040026;640.5900223856731;663.2439019517748;671.7212356871898;33104.337913241754;33602.15994600136;43593.99999999996;44109.77945110278;44256.778716106375;42398;46620.067598648006;46626.53373466264;46670.29994550085;46727.53272467275;8741.519216443094;8876.689315873946;8880.822383552326;8884.555772211395;8887.289016878634;8354.832903341929;8549.95725021377;8551.957240213791;8819.338549608772;10403;10571.524281407317;10887.891121088807;10895.073918716918;10897.782044359108;10898.400587967659;10583.153347732163;10634.521446534885;10637.9362063793;10639.308444951053;10642.733931651694;10483.895161048367;10503.05472507478;10518.579256829718;10545.84181237282;10593;42114.789426052674;42426.57573424288;42449.1510169798;42521.36217956733;42539;3595.3168897909577;3595.82020898954;3598.7660802047785;3762.717796165271;4150.398192262135;31664.208394790083;31857.681423185702;32174.83912580422;32223.35553288921;32267.354652907045;4189.937150942738;4236.712556949747;4252.255855225354;4256.87229383119;4335.046289816235;375647;376733;376803;376814;377166;63586.36413635805;63875.36124638787;63912.36087639157;63944.36055639384;64045.35954640487;38810.6118938807;39602.40596391056;39942.400863987066;42525.14949700989;66764.3323566758;16489.09309987962;16589.253483593267;16591.419300324673;16771.580710482092;16991.150442477825;13242.139260948008;13339.466421343037;13340;13349.933250333686;13352.799708004388;17838.28646854111;18270;19154.52113697169;19654.525910556764;19675.40973770789;7344.853102937911;7358.190599034102;7380.446466515033;7494.325510704063;7568.697252109854;967.9250356001313;973.6494861849728;1026.2200727447046;1031.8194315994672;1130.6042884990188;33530.66469335324;34010;34106;34231.41497531281;34234.657653423645;1112.7607564373536;1187.4181650991125;1217.7442737025146;1233.7162452635944;1277.6167149855191;17625.294988200327;17707.203175857117;17734.911325443547;17779.73330400045;17801.198946047458;568929;571254;572989;573209;573816;61514;62132.51469941242;62260;62317;62324.688376557824;1314.2443095220287;1330.05566048105;1347.3734713358335;1361.4826365981062;1401.1663060479;31508.527372089895;34766.02567294338;36828.631713682524;37048;37101;56808.43191568032;57075.14387284111;57338.42661573498;57559;57685;474591;477838;479440;480582;480622;29835.552466713452;29958.25104372321;30379.240518986317;30615.693843061283;30765.692343076284;49747.00505989788;49907.75046124746;49978.50021499739;50176.749116254185;50840.23739643982;41917.37123943205;42652.146957061304;42993;43017;43662.12675746531;42485.70514614798;42856.78571607122;43068;43165.78417107894;43227.806707039395;42311.7884410576;42805.14389712251;43306.35040474332;43605;43893.122137556435;36064.27871442609;37838.43242351422;38128.42807357836;38193;38280;28989.114149614088;29097.418051639273;29105;29154.125376238746;29263.414731705674 08:39:37 INFO - PROCESS | 22723 | |2;jquery.html;397.4773173277142;420.524806968126;422.3242811501598;433.79394787475945;443.1646346636591;15082.3212955417;18908.9600071996;19792.90103549482;20886.791132088674;21030.57938841222;19711.310104146356;19791.802081979175;20173.495662608442;20237.696434553494;20456.693149602732;5635;5922.58541902067;5930.703464826763;5931.703414829263;5934.614250073753;5548.361938377077;5805.4194580542035;5812.360640329561;5820.505257053155;5823.242978412801;5709.971450142743;5766.250387449626;5767.5962682612235;5769.1346298055205;5773.249477567911;5728.455796699307;5779.393163717833;5816.82549523515;5828.446297601721;5835.649861008353;5048.444671086178;5087.923681144785;5110.693358398508;5111;5152.433232344439;24230.636540451906;24252.757472425405;24423.877880610482;24556.754432455626;24732;2304.5621331946877;2408.8434251773756;2461.2862269941697;2653.9203823885314;2757.889684412641;15234.619134521614;15354.692906141927;15444.92277538605;15493.380264789508;15842.128682922435;1987.801219878015;1996.7104769808298;2064.607724532334;2068.1210485543584;2107.2097963263777;82092;82225.41908929223;83274;84143;86057.56971215167;9357.344985850925;10489.108425783741;10602.522886470128;10733.195010374253;10787.568497260021;13353.332333383292;13502.122362046632;14202.85797142036;14207.71584568303;14275.214863182417;8255.25702686761;8264.421490495608;8345.582720863933;8459.70391036323;8538.146185381536;7822.217778222132;7935;8121.512709237465;8292.460990035628;8300.294474969574;6279.340669229665;6753.223379311442;6830.248672646005;6840.760573379908;6852.417544508673;1782.8395444410066;1823.1103700634378;1850.6021205440625;1959.8530110241788;1984.3650031989625;1042.4475028235047;1063.6011495689118;1121.9326840389604;1134.3534185514177;1169.3802284789076;20054.498637533885;20469.795302047085;20604.896975515025;20956.79043209579;21026.78973210279;1012.8632634594236;1047.879493858201;1049.7218237167158;1067.3275836223286;1089.4498278369372;10603.681889543326;11804.291742495478;11836.408179590986;11856.644300670994;11945.70135746596;443113;482525;484978;494714;497913;80960.59519702363;84654;84789.57605211934;85793;88874.55562722145;1030.7062487191115;1048.8531605575226;1056.5456853553046;1058.1640504001907;1060.7507235799426;17501.47495575135;17772.55568610795;17885.46343609694;18269.817301827345;18538.258469661603;40394.79802600968;40862.79568602138;40949.590504095766;40957.79521102375;41667.37498937458;52556;53508;56606.43393566012;57980.42019579919;60122;8795.428297160664;9014.368994170345;9064.637414503346;9104.954475227581;9139.725808225763;12225.510979560719;12415.193012454161;12565.43455544521;12819.679508012374;13113.934430327787;11338.60314888975;11604.477798499256;11677.474513647076;11696.94151529271;11836.763264734485;5431.23962645222;11224.102071834397;11259.437028148724;11353.886461135284;11690.064794816224;11664.475098620753;11807.527698891949;11857.229280096766;12030.819537707117;12344.284257463343;7802.609869506616;8277.172282771675;8288.295494883003;8431.114732952952;9153.359264851397;9258.768530786785;11349.716257093638;11519.712007199887;11531.942340288246;11571.826422603835 08:39:37 INFO - PROCESS | 22723 | |3;mootools.html;1487.7470829958902;1508.4871143811106;1660.9501714948549;1767.2577517442674;1798.40652584647;8182.8363432731385;8661.91338086619;8667.349948753845;8675.43609665372;8723.302135829133;7570.924290757091;7867.252611001945;8351.74944751657;8559.614817333219;8583.656653733859;2444.523317953004;2468.3829042739317;2474.7154077281075;2475.0347364527847;2476.232367965927;2434.221049264236;2504.536660717773;2520.596704527276;2523.1673547729206;2526.7094284157374;2258.3337915315024;2281.7376001759844;2429.890654920524;2447.730749617541;2449.8775061246956;2395.197608801054;2396.7842894139612;2406.554787364343;2417.576924038295;2430.5260474207535;2453.153661986612;2475;2493.326801763532;2494.787943024845;2497.2757900208917;8699.69551065716;8701.347398945105;8776.16626420489;8781.736547903509;8783.516906570136;5439.782408703647;5575.972120139414;5584.162375643646;5588.636738611977;5591.580631452657;3319.767616266862;3427.725781937439;3444.3111377724554;3467.3758723429773;3506.526618906466;1002.5789168549227;1019.2050200843354;1021.1167340250704;1034.9016843399866;1055.720234137954;12155.878441215564;12156.392180391034;12268.018558515298;12270.570530031406;12277.69305767363;4772.451168115642;4867.902641947212;4884.291777692215;4908.337374454474;4961.08219979305;10296.691099267035;10300.536475858604;10301.175905927508;10314;10316.071553560216;5497.8075767347955;5509.504144626922;5511.5039646432015;5514.6691198528215;5515.834524964257;4481.991551900862;4665;4937.284093806378;5001.9499805002215;5068.923966140511;4013.13717550728;4083.387491876242;4140.60664236897;4189.0574620710095;4202.411662367271;1346.360478772575;1350.2554739078366;1352.1211212711619;1354.620706202265;1359.6125104345215;950.6767698982379;959.510649568725;962.4802606592501;965.821323055237;970.4565443351746;5602.13166959122;5675.290588676416;5703.486686198262;5704.34400043992;5880.911786323209;464.79316704066366;479.8560431870425;482.2982560374646;506.3139446050622;514.920187370958;3954.980225098856;3957.881263562098;3979.721419500665;3992.441058251847;4085.4688890444645;10443.791124177475;10742.516586753614;10803.78392432147;10891;10913.727156821144;10293.228007899437;10676;10823.729406764895;10825.13398928084;10830.296030757976;8044.2760151586635;8216.424850260544;8233.300169485661;8235.8352832943;8239.588020598947;5869.090291004901;5876.41235876409;5957.195778570011;5963.880722385615;5997.520198384032;9941.403515789076;9994.700158995242;9999.500024998575;10077.748056298651;10145.28982971185;10395.688129356131;10402.323848949794;10447.529861156114;10519.579216831547;10536.315139515908;7194.388476979306;7286.927130728624;7398.630068496661;7769.106552746506;7890.960545197467;8407.579621018802;8579.95710021471;8679.783005424915;8683;8703.651853925772;7662.272084151997;7690.115636701851;7704;7745.651445684845;7765.7670269892;7599.392048636207;7653.349465295512;7697.730579429693;7767.844643107219;7864.056313242448;6942.993265976304;6981.057557229709;7046.964765176142;7054.858902821812;7097.183823860322;5008.6744361616375;5147.202183661539;5201.505856943584;5211.5049070338255;5308.309919710413;5182.818601348935;5222.869428264324;5274.393444753902;5275.657082289639;5366.6243362964215 08:39:37 INFO - PROCESS | 22723 | |4;prototype.html;335.7649645248327;345.29904294282613;345.35763479927334;355.4082452716228;356.8064823166508;5360.624756267063;5393.865153371163;5410.6724364515785;5411.512963833255;5423.566114710824;5080.136376815941;5147.794088236466;5193.3248677671945;5253.8949221015555;5357.598180136486;4250.319948808191;4261.318189089746;4268.295731204347;4272.252355837732;4282.336237883125;4251.383549385338;4251.533221038737;4273.465816772903;4273.615374616299;4275.935860962088;3982.661473774718;4014.478117844676;4196.139791342783;4218.599233072853;4228.217779710763;4224.38746381776;4240.724352917051;4243.215005224012;4243.533211346749;4245.787710614472;3788.45067465216;3802.923941521154;3806.745232825949;3818.3890577507464;3828.349180639298;5002.424721157041;5168.896622067575;5185.585153187736;5219.634625576211;5232.1628539433505;4793.3049707792525;4814.879628009293;4823.493533179036;4825.083234185494;4844.927326090112;5544.2063044118995;5550.611457197998;5561;5588.413216612278;5589.776408943638;3871.922561548753;4068.125353049079;4102.528209255944;4168.854090106862;4194.182134483777;5810.518317828969;5815.912761308584;5824.4466775656665;5827.941720582782;5857.502112320415;4212.473440819897;4214.894627634334;4219.97890010548;4220.198162349144;4222.725522841067;4150.398192262105;4161.146964872194;4229.365595160751;4254.361845723104;4264.466941632296;4749.121412538691;4754.667173297905;4761.809527618926;4774;4794.232922732346;5632.324121105494;5634.239377684042;5641.351244606841;5647.548196144298;5651.265335506358;1401.4044031286867;1419.9574012779633;1433.3693175002966;1436.2100844535673;1441.2865631512468;914.881065461499;935.1163150822407;963.9277054220961;973.026973026973;976.2873102635116;5218.817341393033;5224.9738751306;5226.97386513065;5227.634065615446;5231.9476805232225;5533.612647114664;5542.63972841764;5549.861253468695;5552.611317207838;5552.890381386436;5049.368828896388;5160.819371322061;5175.741212939338;5196.636235463557;5233.4243233244315;2935.9412811743646;2940.6765255821842;2960.4753551920776;2970.85145742712;2973.2715484706387;5496.251650021122;5734.254546908875;5794.333651630032;5807.0998995155815;5810.360860305363;5644.996026410648;5647.830565083054;5649.694928466811;5666.6116801383105;5713.228714123623;5703.574106473382;5714.9142762857755;5722.456366645162;5730.538712628253;5733.913991290134;5299.735013249399;5480.6437581557075;5495.972520137374;5514.503694667499;5526.557875370041;5401.675899446046;5454.127339625641;5461.641090729252;5463.945360546344;5465.371482279589;5419.945800542102;5703.800366987136;5706.433479075577;5724.627899186539;5768.451997060272;4003.559608443011;4031.959680403276;4047.2310261050307;4048.149888523443;4050.0279932815324;5538;5543.667379957215;5558.888822223452;5581.772010157759;5583.69289689071;5293.338332708411;5389.353277606712;5446.455354464521;5457.290552228185;5476.3702174250475;5593.524550413098;5626.971865140648;5628.774849005994;5654.180143879197;5654.943450565606;5366.275552800322;5515.972420137874;5632.746526406403;5632.831015069554;5649.4633009864;5511.775611267453;5662.66024038559;5671.298610416941;5676.432356764456;5691.4877661010705;5515.25544051564;5522.420145884625;5531;5534.584906132137;5547.2511210986 08:39:37 INFO - PROCESS | 22723 | |5;yui.html;746.7834328044871;754.4077898849405;791.0744429018052;816.5223344343559;842.4145219072745;14060.29698515074;14426.278686065682;14951.700965980674;15049.322780474877;15209.391624335041;14082.859171408283;14378.06542574732;14405.855941440583;14406.063605865611;14408.35162417691;814.100419036963;824.5547404401616;841.2807049972278;846.7036537211989;857.5540718826206;855.3456605696647;856.8800367948493;857.9485230886136;859.8409294280547;860.3676297921023;890.4568213389826;891.61660485991;892.3084609427681;892.8883889513811;893.3746377535751;884.6328773558965;886.3751055505885;886.6409104312763;886.866969954512;887.3034667785789;654.7773756922669;654.9770758023494;655.0828839624563;655.1450357283743;655.4854439265154;14696.412143514246;14723.411063557445;15203.163825989566;15209.923950380176;15221.61945951349;14010.719785604231;14561.126332420088;14686.412543498247;14714.926425367805;14804.481843135438;11721.70695732605;11751.177417580773;11761.823572646417;11774.705632359173;11813.40932953349;3664.560252769658;3707.610700876396;3770.792606406674;3775.4336849472525;3792.4121761126794;65173.674131629035;67478;67583.32416675819;67717.66141169312;68908.3109168907;10914.672559823219;10922.235443518877;11089.778204436028;11315.773684526428;11407.201495895208;20763.896180519303;20798.168073277204;20837.79162208389;20908;21186.576268474546;7706.7687969361;7764.883526747103;7843;7879.093904200976;8220.095789463154;4325.3728209409455;4345.217860785089;4345.587169218919;4484.573965473275;4610.976945115253;3440.2431465077643;3553.6091029986683;3559;3596.226811235597;3627.165751877083;571.8541771848236;592.1768741449389;630.6279295215845;655.354475841296;671.835400326923;637.8596708724074;690.4096997067435;706.9363757261871;719.6006216549865;733.812877716179;8952.552372381355;9085.049629636964;9292;9474.431534107976;9565.043495650518;611.8317462697705;657.7927952694886;660.9457914626164;740.8110931712379;767.6622286194169;4111.239420707119;4222.852200172979;4225.218334608107;4231.4710661167355;4343.478782546052;90056;91460;93731;95479.52260238654;96621.5168924151;44922;61684;79136;79862;82870;62151.378486215464;76253.61873190598;76338.61830690812;77311.99999999888;77854.22145778582;8983.910160898307;9173.908260917306;9272.490013049348;9406.858897116412;9484.33609647318;47465;47538.52461475341;48346.5165348342;48584.51415485941;49394.259086113016;56861.715691421276;61866;68640;69125.30874691189;71139.64430178022;12562.246265224116;12662.493500260254;12816.782405671447;13037.15258508194;13315.400806963517;13246.933765331112;13440.596782096552;13934.930325348309;14096.577102686935;14729.92635036818;12652.43064062101;13197.472101115847;13368.598942031755;13503.729925401634;13810.378532966242;12697.055841599935;13252.602421927357;13479.326033698471;13703.794443083561;14122.929385353007;12966.870331296566;13723.725525489235;13888.513902013381;14140.50508232207;14628.707425851637;9581.281403894596;9763.75590610212;10026.69919902404;10142.290039697446;10691.198160137865;9433.198178154933;10106.494675266355;10262.384256944608;10643.467826608794;11148.721281968015 08:39:37 INFO - PROCESS | 22723 | __end_tp_report 08:39:37 INFO - PROCESS | 22723 | __start_cc_report 08:39:37 INFO - PROCESS | 22723 | _x_x_mozilla_cycle_collect,1168 08:39:37 INFO - PROCESS | 22723 | __end_cc_report 08:39:37 INFO - PROCESS | 22723 | __startTimestamp1481733577469__endTimestamp 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | ------- Summary: start ------- 08:39:37 INFO - PROCESS | 22723 | Number of tests: 6 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#0] dojo.html Cycles:165 Average:5521.11 Median:5743.25 stddev:622.32 (10.8%) stddev-sans-first:595.68 08:39:37 INFO - PROCESS | 22723 | Values: 3145.7 3192.6 3211.9 3238.3 3249.8 5453.0 5513.6 5520.3 5521.5 5527.1 5568.7 5618.3 5621.0 5628.2 5645.7 5058.7 5076.8 5097.7 5149.5 5174.7 5014.9 5022.6 5119.8 5171.4 5182.7 4973.1 5005.3 5020.5 5028.6 5039.9 5047.6 5055.8 5109.8 5119.9 5148.7 4860.5 4991.7 5009.2 5051.7 5076.0 5347.0 5388.1 5425.9 5451.7 5530.0 5800.3 5811.9 5906.9 5910.5 5913.8 5844.7 5935.1 5953.1 5961.4 5969.3 5518.4 5546.1 5600.0 5605.6 5616.4 6148.0 6152.0 6152.5 6155.2 6156.3 5757.0 5844.0 5887.4 5908.6 5914.7 5850.0 5884.5 5895.2 5896.2 5980.4 5895.2 5914.9 5918.4 5922.7 5924.9 5820.7 5835.0 5867.9 5878.8 5890.9 4460.9 4465.4 4517.5 4581.7 4595.1 4087.3 4104.3 4106.0 4133.6 4139.3 5591.4 5598.0 5599.1 5621.7 5630.6 5769.5 5827.4 5913.3 5963.8 5974.0 5653.3 5660.2 5661.4 5669.7 5688.1 5152.5 5165.2 5166.1 5168.9 5193.3 6040.6 6112.9 6176.5 6225.8 6229.8 5897.2 5924.5 5971.9 5972.1 5975.4 6154.8 6155.2 6158.1 6164.6 6165.1 5823.4 5851.9 5880.7 5894.2 5944.9 5989.8 5992.9 6001.7 6008.3 6009.6 5853.8 5867.3 5868.4 5869.9 5870.7 5668.8 5723.1 5743.3 5756.2 5781.6 5770.0 5825.8 5826.1 5832.2 5845.9 5831.9 5861.9 5864.1 5866.7 5868.4 5579.9 5619.5 5670.7 5685.8 5700.2 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#1] ext.html Cycles:180 Average:63830.27 Median:39206.51 stddev:128029.27 (326.6%) stddev-sans-first:128300.37 08:39:37 INFO - PROCESS | 22723 | Values: 584.0 620.2 640.6 663.2 671.7 33104.3 33602.2 43594.0 44109.8 44256.8 42398.0 46620.1 46626.5 46670.3 46727.5 8741.5 8876.7 8880.8 8884.6 8887.3 8354.8 8550.0 8552.0 8819.3 10403.0 10571.5 10887.9 10895.1 10897.8 10898.4 10583.2 10634.5 10637.9 10639.3 10642.7 10483.9 10503.1 10518.6 10545.8 10593.0 42114.8 42426.6 42449.2 42521.4 42539.0 3595.3 3595.8 3598.8 3762.7 4150.4 31664.2 31857.7 32174.8 32223.4 32267.4 4189.9 4236.7 4252.3 4256.9 4335.0 375647.0 376733.0 376803.0 376814.0 377166.0 63586.4 63875.4 63912.4 63944.4 64045.4 38810.6 39602.4 39942.4 42525.1 66764.3 16489.1 16589.3 16591.4 16771.6 16991.2 13242.1 13339.5 13340.0 13349.9 13352.8 17838.3 18270.0 19154.5 19654.5 19675.4 7344.9 7358.2 7380.4 7494.3 7568.7 967.9 973.6 1026.2 1031.8 1130.6 33530.7 34010.0 34106.0 34231.4 34234.7 1112.8 1187.4 1217.7 1233.7 1277.6 17625.3 17707.2 17734.9 17779.7 17801.2 568929.0 571254.0 572989.0 573209.0 573816.0 61514.0 62132.5 62260.0 62317.0 62324.7 1314.2 1330.1 1347.4 1361.5 1401.2 31508.5 34766.0 36828.6 37048.0 37101.0 56808.4 57075.1 57338.4 57559.0 57685.0 474591.0 477838.0 479440.0 480582.0 480622.0 29835.6 29958.3 30379.2 30615.7 30765.7 49747.0 49907.8 49978.5 50176.7 50840.2 41917.4 42652.1 42993.0 43017.0 43662.1 42485.7 42856.8 43068.0 43165.8 43227.8 42311.8 42805.1 43306.4 43605.0 43893.1 36064.3 37838.4 38128.4 38193.0 38280.0 28989.1 29097.4 29105.0 29154.1 29263.4 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#2] jquery.html Cycles:180 Average:28788.74 Median:24338.32 stddev:79208.31 (325.4%) stddev-sans-first:79401.83 08:39:37 INFO - PROCESS | 22723 | Values: 397.5 420.5 422.3 433.8 443.2 15082.3 18909.0 19792.9 20886.8 21030.6 19711.3 19791.8 20173.5 20237.7 20456.7 5635.0 5922.6 5930.7 5931.7 5934.6 5548.4 5805.4 5812.4 5820.5 5823.2 5710.0 5766.3 5767.6 5769.1 5773.2 5728.5 5779.4 5816.8 5828.4 5835.6 5048.4 5087.9 5110.7 5111.0 5152.4 24230.6 24252.8 24423.9 24556.8 24732.0 2304.6 2408.8 2461.3 2653.9 2757.9 15234.6 15354.7 15444.9 15493.4 15842.1 1987.8 1996.7 2064.6 2068.1 2107.2 82092.0 82225.4 83274.0 84143.0 86057.6 9357.3 10489.1 10602.5 10733.2 10787.6 13353.3 13502.1 14202.9 14207.7 14275.2 8255.3 8264.4 8345.6 8459.7 8538.1 7822.2 7935.0 8121.5 8292.5 8300.3 6279.3 6753.2 6830.2 6840.8 6852.4 1782.8 1823.1 1850.6 1959.9 1984.4 1042.4 1063.6 1121.9 1134.4 1169.4 20054.5 20469.8 20604.9 20956.8 21026.8 1012.9 1047.9 1049.7 1067.3 1089.4 10603.7 11804.3 11836.4 11856.6 11945.7 443113.0 482525.0 484978.0 494714.0 497913.0 80960.6 84654.0 84789.6 85793.0 88874.6 1030.7 1048.9 1056.5 1058.2 1060.8 17501.5 17772.6 17885.5 18269.8 18538.3 40394.8 40862.8 40949.6 40957.8 41667.4 52556.0 53508.0 56606.4 57980.4 60122.0 8795.4 9014.4 9064.6 9105.0 9139.7 12225.5 12415.2 12565.4 12819.7 13113.9 11338.6 11604.5 11677.5 11696.9 11836.8 5431.2 11224.1 11259.4 11353.9 11690.1 11664.5 11807.5 11857.2 12030.8 12344.3 7802.6 8277.2 8288.3 8431.1 9153.4 9258.8 11349.7 11519.7 11531.9 11571.8 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#3] mootools.html Cycles:180 Average:5802.27 Median:4922.81 stddev:3256.72 (66.2%) stddev-sans-first:3249.71 08:39:37 INFO - PROCESS | 22723 | Values: 1487.7 1508.5 1661.0 1767.3 1798.4 8182.8 8661.9 8667.3 8675.4 8723.3 7570.9 7867.3 8351.7 8559.6 8583.7 2444.5 2468.4 2474.7 2475.0 2476.2 2434.2 2504.5 2520.6 2523.2 2526.7 2258.3 2281.7 2429.9 2447.7 2449.9 2395.2 2396.8 2406.6 2417.6 2430.5 2453.2 2475.0 2493.3 2494.8 2497.3 8699.7 8701.3 8776.2 8781.7 8783.5 5439.8 5576.0 5584.2 5588.6 5591.6 3319.8 3427.7 3444.3 3467.4 3506.5 1002.6 1019.2 1021.1 1034.9 1055.7 12155.9 12156.4 12268.0 12270.6 12277.7 4772.5 4867.9 4884.3 4908.3 4961.1 10296.7 10300.5 10301.2 10314.0 10316.1 5497.8 5509.5 5511.5 5514.7 5515.8 4482.0 4665.0 4937.3 5001.9 5068.9 4013.1 4083.4 4140.6 4189.1 4202.4 1346.4 1350.3 1352.1 1354.6 1359.6 950.7 959.5 962.5 965.8 970.5 5602.1 5675.3 5703.5 5704.3 5880.9 464.8 479.9 482.3 506.3 514.9 3955.0 3957.9 3979.7 3992.4 4085.5 10443.8 10742.5 10803.8 10891.0 10913.7 10293.2 10676.0 10823.7 10825.1 10830.3 8044.3 8216.4 8233.3 8235.8 8239.6 5869.1 5876.4 5957.2 5963.9 5997.5 9941.4 9994.7 9999.5 10077.7 10145.3 10395.7 10402.3 10447.5 10519.6 10536.3 7194.4 7286.9 7398.6 7769.1 7891.0 8407.6 8580.0 8679.8 8683.0 8703.7 7662.3 7690.1 7704.0 7745.7 7765.8 7599.4 7653.3 7697.7 7767.8 7864.1 6943.0 6981.1 7047.0 7054.9 7097.2 5008.7 5147.2 5201.5 5211.5 5308.3 5182.8 5222.9 5274.4 5275.7 5366.6 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#4] prototype.html Cycles:180 Average:4674.85 Median:5328.67 stddev:1341.91 (25.2%) stddev-sans-first:1305.56 08:39:37 INFO - PROCESS | 22723 | Values: 335.8 345.3 345.4 355.4 356.8 5360.6 5393.9 5410.7 5411.5 5423.6 5080.1 5147.8 5193.3 5253.9 5357.6 4250.3 4261.3 4268.3 4272.3 4282.3 4251.4 4251.5 4273.5 4273.6 4275.9 3982.7 4014.5 4196.1 4218.6 4228.2 4224.4 4240.7 4243.2 4243.5 4245.8 3788.5 3802.9 3806.7 3818.4 3828.3 5002.4 5168.9 5185.6 5219.6 5232.2 4793.3 4814.9 4823.5 4825.1 4844.9 5544.2 5550.6 5561.0 5588.4 5589.8 3871.9 4068.1 4102.5 4168.9 4194.2 5810.5 5815.9 5824.4 5827.9 5857.5 4212.5 4214.9 4220.0 4220.2 4222.7 4150.4 4161.1 4229.4 4254.4 4264.5 4749.1 4754.7 4761.8 4774.0 4794.2 5632.3 5634.2 5641.4 5647.5 5651.3 1401.4 1420.0 1433.4 1436.2 1441.3 914.9 935.1 963.9 973.0 976.3 5218.8 5225.0 5227.0 5227.6 5231.9 5533.6 5542.6 5549.9 5552.6 5552.9 5049.4 5160.8 5175.7 5196.6 5233.4 2935.9 2940.7 2960.5 2970.9 2973.3 5496.3 5734.3 5794.3 5807.1 5810.4 5645.0 5647.8 5649.7 5666.6 5713.2 5703.6 5714.9 5722.5 5730.5 5733.9 5299.7 5480.6 5496.0 5514.5 5526.6 5401.7 5454.1 5461.6 5463.9 5465.4 5419.9 5703.8 5706.4 5724.6 5768.5 4003.6 4032.0 4047.2 4048.1 4050.0 5538.0 5543.7 5558.9 5581.8 5583.7 5293.3 5389.4 5446.5 5457.3 5476.4 5593.5 5627.0 5628.8 5654.2 5654.9 5366.3 5516.0 5632.7 5632.8 5649.5 5511.8 5662.7 5671.3 5676.4 5691.5 5515.3 5522.4 5531.0 5534.6 5547.3 08:39:37 INFO - PROCESS | 22723 | 08:39:37 INFO - PROCESS | 22723 | [#5] yui.html Cycles:180 Average:18272.17 Median:48465.52 stddev:24490.19 (50.5%) stddev-sans-first:24523.54 08:39:37 INFO - PROCESS | 22723 | Values: 746.8 754.4 791.1 816.5 842.4 14060.3 14426.3 14951.7 15049.3 15209.4 14082.9 14378.1 14405.9 14406.1 14408.4 814.1 824.6 841.3 846.7 857.6 855.3 856.9 857.9 859.8 860.4 890.5 891.6 892.3 892.9 893.4 884.6 886.4 886.6 886.9 887.3 654.8 655.0 655.1 655.1 655.5 14696.4 14723.4 15203.2 15209.9 15221.6 14010.7 14561.1 14686.4 14714.9 14804.5 11721.7 11751.2 11761.8 11774.7 11813.4 3664.6 3707.6 3770.8 3775.4 3792.4 65173.7 67478.0 67583.3 67717.7 68908.3 10914.7 10922.2 11089.8 11315.8 11407.2 20763.9 20798.2 20837.8 20908.0 21186.6 7706.8 7764.9 7843.0 7879.1 8220.1 4325.4 4345.2 4345.6 4484.6 4611.0 3440.2 3553.6 3559.0 3596.2 3627.2 571.9 592.2 630.6 655.4 671.8 637.9 690.4 706.9 719.6 733.8 8952.6 9085.0 9292.0 9474.4 9565.0 611.8 657.8 660.9 740.8 767.7 4111.2 4222.9 4225.2 4231.5 4343.5 90056.0 91460.0 93731.0 95479.5 96621.5 44922.0 61684.0 79136.0 79862.0 82870.0 62151.4 76253.6 76338.6 77312.0 77854.2 8983.9 9173.9 9272.5 9406.9 9484.3 47465.0 47538.5 48346.5 48584.5 49394.3 56861.7 61866.0 68640.0 69125.3 71139.6 12562.2 12662.5 12816.8 13037.2 13315.4 13246.9 13440.6 13934.9 14096.6 14729.9 12652.4 13197.5 13368.6 13503.7 13810.4 12697.1 13252.6 13479.3 13703.8 14122.9 12966.9 13723.7 13888.5 14140.5 14628.7 9581.3 9763.8 10026.7 10142.3 10691.2 9433.2 10106.5 10262.4 10643.5 11148.7 08:39:37 INFO - PROCESS | 22723 | -------- Summary: end -------- 08:39:37 INFO - PROCESS | 22723 | 08:39:38 INFO - TEST-INFO | 22723: exit 0 08:39:38 INFO - TEST-OK | dromaeo_css | took 1115215ms 08:39:38 INFO - TEST-START | kraken 08:39:38 INFO - operating with platform_type : linux_ 08:39:38 INFO - Initialising browser for kraken test... 08:39:38 INFO - TEST-INFO | started process 23043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3oHps/profile http://localhost:42581/getInfo.html) 08:39:42 INFO - PROCESS | 23043 | __metrics Screen width/height:1600/1200 08:39:42 INFO - PROCESS | 23043 | colorDepth:24 08:39:42 INFO - PROCESS | 23043 | Browser inner width/height: 1024/697 08:39:42 INFO - PROCESS | 23043 | __metrics 08:39:42 INFO - PROCESS | 23043 | 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" 08:39:42 INFO - PROCESS | 23043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:39:43 INFO - PROCESS | 23043 | console.error: PushService: 08:39:43 INFO - PROCESS | 23043 | stateChangeProcessEnqueue: Error transitioning state 08:39:43 INFO - PROCESS | 23043 | UnknownError 08:39:43 INFO - TEST-INFO | 23043: exit 0 08:39:43 INFO - Browser initialized. 08:39:43 INFO - Running cycle 1/1 for kraken test... 08:39:43 INFO - TEST-INFO | started process 23134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3oHps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:39:55 INFO - PROCESS | 23134 | RSS: Main: 147959808 08:39:55 INFO - PROCESS | 23134 | 08:39:57 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42581/tests/kraken/driver.html?testName=audio-beat-detection) 08:39:58 INFO - PROCESS | 23134 | RSS: Main: 188874752 08:39:58 INFO - PROCESS | 23134 | 08:40:01 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42581/tests/kraken/driver.html?testName=audio-dft) 08:40:01 INFO - PROCESS | 23134 | RSS: Main: 178278400 08:40:01 INFO - PROCESS | 23134 | 08:40:04 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42581/tests/kraken/driver.html?testName=audio-fft) 08:40:05 INFO - PROCESS | 23134 | RSS: Main: 269905920 08:40:05 INFO - PROCESS | 23134 | 08:40:07 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42581/tests/kraken/driver.html?testName=audio-oscillator) 08:40:07 INFO - PROCESS | 23134 | RSS: Main: 176496640 08:40:07 INFO - PROCESS | 23134 | 08:40:10 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:40:10 INFO - PROCESS | 23134 | RSS: Main: 179093504 08:40:10 INFO - PROCESS | 23134 | 08:40:13 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42581/tests/kraken/driver.html?testName=imaging-darkroom) 08:40:14 INFO - PROCESS | 23134 | RSS: Main: 218071040 08:40:14 INFO - PROCESS | 23134 | 08:40:17 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42581/tests/kraken/driver.html?testName=imaging-desaturate) 08:40:18 INFO - PROCESS | 23134 | RSS: Main: 216154112 08:40:18 INFO - PROCESS | 23134 | 08:40:20 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42581/tests/kraken/driver.html?testName=json-parse-financial) 08:40:21 INFO - PROCESS | 23134 | RSS: Main: 215121920 08:40:21 INFO - PROCESS | 23134 | 08:40:22 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:40:23 INFO - PROCESS | 23134 | RSS: Main: 176594944 08:40:23 INFO - PROCESS | 23134 | 08:40:25 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:40:25 INFO - PROCESS | 23134 | RSS: Main: 184090624 08:40:25 INFO - PROCESS | 23134 | 08:40:27 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:40:28 INFO - PROCESS | 23134 | RSS: Main: 190214144 08:40:28 INFO - PROCESS | 23134 | 08:40:30 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:40:31 INFO - PROCESS | 23134 | RSS: Main: 199806976 08:40:31 INFO - PROCESS | 23134 | 08:40:34 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:40:34 INFO - PROCESS | 23134 | RSS: Main: 195522560 08:40:34 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | Cycle 1(1): loaded http://localhost:42581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42581/tests/kraken/driver.html?testName=ai-astar) 08:40:36 INFO - PROCESS | 23134 | RSS: Main: 247603200 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | __start_tp_report 08:40:36 INFO - PROCESS | 23134 | _x_x_mozilla_page_load 08:40:36 INFO - PROCESS | 23134 | _x_x_mozilla_page_load_details 08:40:36 INFO - PROCESS | 23134 | |i|pagename|runs| 08:40:36 INFO - PROCESS | 23134 | |0;ai-astar;100;113;110;110;111;108;110;110;111;110 08:40:36 INFO - PROCESS | 23134 | |1;audio-beat-detection;153;117;118;145;121;118;120;118;151;119 08:40:36 INFO - PROCESS | 23134 | |2;audio-dft;160;160;162;161;162;160;161;161;162;161 08:40:36 INFO - PROCESS | 23134 | |3;audio-fft;75;76;75;109;76;77;75;75;97;76 08:40:36 INFO - PROCESS | 23134 | |4;audio-oscillator;82;81;108;82;82;81;97;81;81;117 08:40:36 INFO - PROCESS | 23134 | |5;imaging-gaussian-blur;117;117;118;118;117;117;117;117;117;117 08:40:36 INFO - PROCESS | 23134 | |6;imaging-darkroom;148;147;146;146;146;146;146;145;146;146 08:40:36 INFO - PROCESS | 23134 | |7;imaging-desaturate;85;85;85;85;86;85;85;85;85;85 08:40:36 INFO - PROCESS | 23134 | |8;json-parse-financial;51;49;52;50;49;50;52;50;52;51 08:40:36 INFO - PROCESS | 23134 | |9;json-stringify-tinderbox;58;58;56;58;58;58;57;58;58;58 08:40:36 INFO - PROCESS | 23134 | |10;stanford-crypto-aes;75;78;80;75;76;75;75;74;76;74 08:40:36 INFO - PROCESS | 23134 | |11;stanford-crypto-ccm;123;122;123;131;121;122;129;123;177;120 08:40:36 INFO - PROCESS | 23134 | |12;stanford-crypto-pbkdf2;158;160;157;155;158;155;160;156;159;156 08:40:36 INFO - PROCESS | 23134 | |13;stanford-crypto-sha256-iterative;71;63;61;63;64;63;63;62;62;62 08:40:36 INFO - PROCESS | 23134 | __end_tp_report 08:40:36 INFO - PROCESS | 23134 | __start_cc_report 08:40:36 INFO - PROCESS | 23134 | _x_x_mozilla_cycle_collect,1639 08:40:36 INFO - PROCESS | 23134 | __end_cc_report 08:40:36 INFO - PROCESS | 23134 | __startTimestamp1481733636720__endTimestamp 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | ------- Summary: start ------- 08:40:36 INFO - PROCESS | 23134 | Number of tests: 14 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.50 (3.2%) stddev-sans-first:1.32 08:40:36 INFO - PROCESS | 23134 | Values: 100.0 113.0 110.0 110.0 111.0 108.0 110.0 110.0 111.0 110.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:120.50 stddev:15.12 (12.5%) stddev-sans-first:13.06 08:40:36 INFO - PROCESS | 23134 | Values: 153.0 117.0 118.0 145.0 121.0 118.0 120.0 118.0 151.0 119.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 08:40:36 INFO - PROCESS | 23134 | Values: 160.0 160.0 162.0 161.0 162.0 160.0 161.0 161.0 162.0 161.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:11.90 (15.7%) stddev-sans-first:12.42 08:40:36 INFO - PROCESS | 23134 | Values: 75.0 76.0 75.0 109.0 76.0 77.0 75.0 75.0 97.0 76.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:81.50 stddev:13.38 (16.4%) stddev-sans-first:13.94 08:40:36 INFO - PROCESS | 23134 | Values: 82.0 81.0 108.0 82.0 82.0 81.0 97.0 81.0 81.0 117.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:40:36 INFO - PROCESS | 23134 | Values: 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.50 08:40:36 INFO - PROCESS | 23134 | Values: 148.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 08:40:36 INFO - PROCESS | 23134 | Values: 85.0 85.0 85.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:1.17 (2.3%) stddev-sans-first:1.24 08:40:36 INFO - PROCESS | 23134 | Values: 51.0 49.0 52.0 50.0 49.0 50.0 52.0 50.0 52.0 51.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 08:40:36 INFO - PROCESS | 23134 | Values: 58.0 58.0 56.0 58.0 58.0 58.0 57.0 58.0 58.0 58.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:1.87 (2.5%) stddev-sans-first:1.96 08:40:36 INFO - PROCESS | 23134 | Values: 75.0 78.0 80.0 75.0 76.0 75.0 75.0 74.0 76.0 74.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:123.00 stddev:17.19 (14.0%) stddev-sans-first:18.09 08:40:36 INFO - PROCESS | 23134 | Values: 123.0 122.0 123.0 131.0 121.0 122.0 129.0 123.0 177.0 120.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:158.00 stddev:1.90 (1.2%) stddev-sans-first:2.00 08:40:36 INFO - PROCESS | 23134 | Values: 158.0 160.0 157.0 155.0 158.0 155.0 160.0 156.0 159.0 156.0 08:40:36 INFO - PROCESS | 23134 | 08:40:36 INFO - PROCESS | 23134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.80 (4.4%) stddev-sans-first:0.88 08:40:36 INFO - PROCESS | 23134 | Values: 71.0 63.0 61.0 63.0 64.0 63.0 63.0 62.0 62.0 62.0 08:40:36 INFO - PROCESS | 23134 | -------- Summary: end -------- 08:40:36 INFO - PROCESS | 23134 | 08:40:37 INFO - TEST-INFO | 23134: exit 0 08:40:37 INFO - TEST-OK | kraken | took 59505ms 08:40:37 INFO - SUITE-END | took 1174s 08:40:37 INFO - Completed test suite (00:19:34) 08:40:37 INFO - javascript benchmark 08:40:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.669704681008, 3192.64880863105, 3211.8875839345615, 3238.2713889374877, 3249.756268279878, 5452.9727351363235, 5513.586481013925, 5520.337559492857, 5521.503064724174, 5527.088030474972, 5568.681908777118, 5618.325800903897, 5621.0, 5628.183913332575, 5645.717714114288, 5058.671186372892, 5076.796928122889, 5097.745112744366, 5149.510796474329, 5174.715390653512, 5014.949850501503, 5022.5730812880765, 5119.846404607849, 5171.3535808024, 5182.6631268967585, 4973.129702302101, 5005.29925810385, 5020.548150666439, 5028.647994640377, 5039.874003149914, 5047.64666473347, 5055.823046193403, 5109.795608175668, 5119.948800511985, 5148.665336753136, 4860.538248866352, 4991.650584459089, 5009.198528235464, 5051.747412629391, 5076.0, 5347.0, 5388.0570900092325, 5425.864353391197, 5451.700156491392, 5529.972350138264, 5800.303963524404, 5811.88376232473, 5906.940930590682, 5910.468057874769, 5913.763449462016, 5844.678542680151, 5935.050391937312, 5953.1070339449, 5961.403859614047, 5969.283685957669, 5518.448155184489, 5546.084895992157, 5600.019996500596, 5605.635633683797, 5616.410276920946, 6148.0, 6152.046432802923, 6152.477039451607, 6155.199824022849, 6156.29202641693, 5757.0, 5843.970780146072, 5887.4406931341455, 5908.586398952118, 5914.704264786744, 5850.034744267234, 5884.529237660977, 5895.20414744004, 5896.174535565025, 5980.372060933626, 5895.174675545427, 5914.852128696817, 5918.437748413894, 5922.733476993546, 5924.851878702981, 5820.650760954271, 5835.037218858925, 5867.853303667443, 5878.794242201502, 5890.852728681732, 4460.910781784346, 4465.441819772528, 4517.457905051415, 4581.679282450264, 4595.1039547287955, 4087.2642924273323, 4104.302268614343, 4106.0, 4133.586641335843, 4139.296319625671, 5591.3569939456665, 5598.0, 5599.076152434803, 5621.747021384048, 5630.60585758993, 5769.509591684754, 5827.446392592697, 5913.2608423947, 5963.761449542057, 5974.0, 5653.349864765522, 5660.15097735343, 5661.405552417019, 5669.716514174274, 5688.089905615165, 5152.5362717354865, 5165.199394093921, 5166.095933211673, 5168.948310516922, 5193.298904647824, 6040.607360521552, 6112.908306375319, 6176.50575995538, 6225.782097626561, 6229.844253893598, 5897.233359663388, 5924.4667979882015, 5971.880562388815, 5972.074328479092, 5975.40245975399, 6154.784582539769, 6155.199824022849, 6158.076288556752, 6164.568480206342, 6165.10605962124, 5823.4467725566, 5851.882962340645, 5880.676562789087, 5894.174815525916, 5944.940550594439, 5989.790357337647, 5992.940070599238, 6001.669908155093, 6008.309044459768, 6009.639421634716, 5853.765849366148, 5867.266591676041, 5868.413158684098, 5869.941300586939, 5870.706464676835, 5668.7732490701555, 5723.084306510938, 5743.253377061123, 5756.16535602327, 5781.595288329945, 5769.9711501442225, 5825.825225243249, 5826.067829147316, 5832.24180856486, 5845.853853653693, 5831.912521312269, 5861.9413805861395, 5864.091065884794, 5866.67733274674, 5868.38381969887, 5579.944200557942, 5619.494245517923, 5670.659760414388, 5685.800996965087, 5700.2304688868135], "value": 5479.253056797726, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.9883202335953, 620.1813606040026, 640.5900223856731, 663.2439019517748, 671.7212356871898, 33104.337913241754, 33602.15994600136, 43593.99999999996, 44109.77945110278, 44256.778716106375, 42398.0, 46620.067598648006, 46626.53373466264, 46670.29994550085, 46727.53272467275, 8741.519216443094, 8876.689315873946, 8880.822383552326, 8884.555772211395, 8887.289016878634, 8354.832903341929, 8549.95725021377, 8551.957240213791, 8819.338549608772, 10403.0, 10571.524281407317, 10887.891121088807, 10895.073918716918, 10897.782044359108, 10898.400587967659, 10583.153347732163, 10634.521446534885, 10637.9362063793, 10639.308444951053, 10642.733931651694, 10483.895161048367, 10503.05472507478, 10518.579256829718, 10545.84181237282, 10593.0, 42114.789426052674, 42426.57573424288, 42449.1510169798, 42521.36217956733, 42539.0, 3595.3168897909577, 3595.82020898954, 3598.7660802047785, 3762.717796165271, 4150.398192262135, 31664.208394790083, 31857.681423185702, 32174.83912580422, 32223.35553288921, 32267.354652907045, 4189.937150942738, 4236.712556949747, 4252.255855225354, 4256.87229383119, 4335.046289816235, 375647.0, 376733.0, 376803.0, 376814.0, 377166.0, 63586.36413635805, 63875.36124638787, 63912.36087639157, 63944.36055639384, 64045.35954640487, 38810.6118938807, 39602.40596391056, 39942.400863987066, 42525.14949700989, 66764.3323566758, 16489.09309987962, 16589.253483593267, 16591.419300324673, 16771.580710482092, 16991.150442477825, 13242.139260948008, 13339.466421343037, 13340.0, 13349.933250333686, 13352.799708004388, 17838.28646854111, 18270.0, 19154.52113697169, 19654.525910556764, 19675.40973770789, 7344.853102937911, 7358.190599034102, 7380.446466515033, 7494.325510704063, 7568.697252109854, 967.9250356001313, 973.6494861849728, 1026.2200727447046, 1031.8194315994672, 1130.6042884990188, 33530.66469335324, 34010.0, 34106.0, 34231.41497531281, 34234.657653423645, 1112.7607564373536, 1187.4181650991125, 1217.7442737025146, 1233.7162452635944, 1277.6167149855191, 17625.294988200327, 17707.203175857117, 17734.911325443547, 17779.73330400045, 17801.198946047458, 568929.0, 571254.0, 572989.0, 573209.0, 573816.0, 61514.0, 62132.51469941242, 62260.0, 62317.0, 62324.688376557824, 1314.2443095220287, 1330.05566048105, 1347.3734713358335, 1361.4826365981062, 1401.1663060479, 31508.527372089895, 34766.02567294338, 36828.631713682524, 37048.0, 37101.0, 56808.43191568032, 57075.14387284111, 57338.42661573498, 57559.0, 57685.0, 474591.0, 477838.0, 479440.0, 480582.0, 480622.0, 29835.552466713452, 29958.25104372321, 30379.240518986317, 30615.693843061283, 30765.692343076284, 49747.00505989788, 49907.75046124746, 49978.50021499739, 50176.749116254185, 50840.23739643982, 41917.37123943205, 42652.146957061304, 42993.0, 43017.0, 43662.12675746531, 42485.70514614798, 42856.78571607122, 43068.0, 43165.78417107894, 43227.806707039395, 42311.7884410576, 42805.14389712251, 43306.35040474332, 43605.0, 43893.122137556435, 36064.27871442609, 37838.43242351422, 38128.42807357836, 38193.0, 38280.0, 28989.114149614088, 29097.418051639273, 29105.0, 29154.125376238746, 29263.414731705674], "value": 20974.342955319215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.4773173277142, 420.524806968126, 422.3242811501598, 433.79394787475945, 443.1646346636591, 15082.3212955417, 18908.9600071996, 19792.90103549482, 20886.791132088674, 21030.57938841222, 19711.310104146356, 19791.802081979175, 20173.495662608442, 20237.696434553494, 20456.693149602732, 5635.0, 5922.58541902067, 5930.703464826763, 5931.703414829263, 5934.614250073753, 5548.361938377077, 5805.4194580542035, 5812.360640329561, 5820.505257053155, 5823.242978412801, 5709.971450142743, 5766.250387449626, 5767.5962682612235, 5769.1346298055205, 5773.249477567911, 5728.455796699307, 5779.393163717833, 5816.82549523515, 5828.446297601721, 5835.649861008353, 5048.444671086178, 5087.923681144785, 5110.693358398508, 5111.0, 5152.433232344439, 24230.636540451906, 24252.757472425405, 24423.877880610482, 24556.754432455626, 24732.0, 2304.5621331946877, 2408.8434251773756, 2461.2862269941697, 2653.9203823885314, 2757.889684412641, 15234.619134521614, 15354.692906141927, 15444.92277538605, 15493.380264789508, 15842.128682922435, 1987.801219878015, 1996.7104769808298, 2064.607724532334, 2068.1210485543584, 2107.2097963263777, 82092.0, 82225.41908929223, 83274.0, 84143.0, 86057.56971215167, 9357.344985850925, 10489.108425783741, 10602.522886470128, 10733.195010374253, 10787.568497260021, 13353.332333383292, 13502.122362046632, 14202.85797142036, 14207.71584568303, 14275.214863182417, 8255.25702686761, 8264.421490495608, 8345.582720863933, 8459.70391036323, 8538.146185381536, 7822.217778222132, 7935.0, 8121.512709237465, 8292.460990035628, 8300.294474969574, 6279.340669229665, 6753.223379311442, 6830.248672646005, 6840.760573379908, 6852.417544508673, 1782.8395444410066, 1823.1103700634378, 1850.6021205440625, 1959.8530110241788, 1984.3650031989625, 1042.4475028235047, 1063.6011495689118, 1121.9326840389604, 1134.3534185514177, 1169.3802284789076, 20054.498637533885, 20469.795302047085, 20604.896975515025, 20956.79043209579, 21026.78973210279, 1012.8632634594236, 1047.879493858201, 1049.7218237167158, 1067.3275836223286, 1089.4498278369372, 10603.681889543326, 11804.291742495478, 11836.408179590986, 11856.644300670994, 11945.70135746596, 443113.0, 482525.0, 484978.0, 494714.0, 497913.0, 80960.59519702363, 84654.0, 84789.57605211934, 85793.0, 88874.55562722145, 1030.7062487191115, 1048.8531605575226, 1056.5456853553046, 1058.1640504001907, 1060.7507235799426, 17501.47495575135, 17772.55568610795, 17885.46343609694, 18269.817301827345, 18538.258469661603, 40394.79802600968, 40862.79568602138, 40949.590504095766, 40957.79521102375, 41667.37498937458, 52556.0, 53508.0, 56606.43393566012, 57980.42019579919, 60122.0, 8795.428297160664, 9014.368994170345, 9064.637414503346, 9104.954475227581, 9139.725808225763, 12225.510979560719, 12415.193012454161, 12565.43455544521, 12819.679508012374, 13113.934430327787, 11338.60314888975, 11604.477798499256, 11677.474513647076, 11696.94151529271, 11836.763264734485, 5431.23962645222, 11224.102071834397, 11259.437028148724, 11353.886461135284, 11690.064794816224, 11664.475098620753, 11807.527698891949, 11857.229280096766, 12030.819537707117, 12344.284257463343, 7802.609869506616, 8277.172282771675, 8288.295494883003, 8431.114732952952, 9153.359264851397, 9258.768530786785, 11349.716257093638, 11519.712007199887, 11531.942340288246, 11571.826422603835], "value": 9469.473614176995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1487.7470829958902, 1508.4871143811106, 1660.9501714948549, 1767.2577517442674, 1798.40652584647, 8182.8363432731385, 8661.91338086619, 8667.349948753845, 8675.43609665372, 8723.302135829133, 7570.924290757091, 7867.252611001945, 8351.74944751657, 8559.614817333219, 8583.656653733859, 2444.523317953004, 2468.3829042739317, 2474.7154077281075, 2475.0347364527847, 2476.232367965927, 2434.221049264236, 2504.536660717773, 2520.596704527276, 2523.1673547729206, 2526.7094284157374, 2258.3337915315024, 2281.7376001759844, 2429.890654920524, 2447.730749617541, 2449.8775061246956, 2395.197608801054, 2396.7842894139612, 2406.554787364343, 2417.576924038295, 2430.5260474207535, 2453.153661986612, 2475.0, 2493.326801763532, 2494.787943024845, 2497.2757900208917, 8699.69551065716, 8701.347398945105, 8776.16626420489, 8781.736547903509, 8783.516906570136, 5439.782408703647, 5575.972120139414, 5584.162375643646, 5588.636738611977, 5591.580631452657, 3319.767616266862, 3427.725781937439, 3444.3111377724554, 3467.3758723429773, 3506.526618906466, 1002.5789168549227, 1019.2050200843354, 1021.1167340250704, 1034.9016843399866, 1055.720234137954, 12155.878441215564, 12156.392180391034, 12268.018558515298, 12270.570530031406, 12277.69305767363, 4772.451168115642, 4867.902641947212, 4884.291777692215, 4908.337374454474, 4961.08219979305, 10296.691099267035, 10300.536475858604, 10301.175905927508, 10314.0, 10316.071553560216, 5497.8075767347955, 5509.504144626922, 5511.5039646432015, 5514.6691198528215, 5515.834524964257, 4481.991551900862, 4665.0, 4937.284093806378, 5001.9499805002215, 5068.923966140511, 4013.13717550728, 4083.387491876242, 4140.60664236897, 4189.0574620710095, 4202.411662367271, 1346.360478772575, 1350.2554739078366, 1352.1211212711619, 1354.620706202265, 1359.6125104345215, 950.6767698982379, 959.510649568725, 962.4802606592501, 965.821323055237, 970.4565443351746, 5602.13166959122, 5675.290588676416, 5703.486686198262, 5704.34400043992, 5880.911786323209, 464.79316704066366, 479.8560431870425, 482.2982560374646, 506.3139446050622, 514.920187370958, 3954.980225098856, 3957.881263562098, 3979.721419500665, 3992.441058251847, 4085.4688890444645, 10443.791124177475, 10742.516586753614, 10803.78392432147, 10891.0, 10913.727156821144, 10293.228007899437, 10676.0, 10823.729406764895, 10825.13398928084, 10830.296030757976, 8044.2760151586635, 8216.424850260544, 8233.300169485661, 8235.8352832943, 8239.588020598947, 5869.090291004901, 5876.41235876409, 5957.195778570011, 5963.880722385615, 5997.520198384032, 9941.403515789076, 9994.700158995242, 9999.500024998575, 10077.748056298651, 10145.28982971185, 10395.688129356131, 10402.323848949794, 10447.529861156114, 10519.579216831547, 10536.315139515908, 7194.388476979306, 7286.927130728624, 7398.630068496661, 7769.106552746506, 7890.960545197467, 8407.579621018802, 8579.95710021471, 8679.783005424915, 8683.0, 8703.651853925772, 7662.272084151997, 7690.115636701851, 7704.0, 7745.651445684845, 7765.7670269892, 7599.392048636207, 7653.349465295512, 7697.730579429693, 7767.844643107219, 7864.056313242448, 6942.993265976304, 6981.057557229709, 7046.964765176142, 7054.858902821812, 7097.183823860322, 5008.6744361616375, 5147.202183661539, 5201.505856943584, 5211.5049070338255, 5308.309919710413, 5182.818601348935, 5222.869428264324, 5274.393444753902, 5275.657082289639, 5366.6243362964215], "value": 4602.645018553952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.7649645248327, 345.29904294282613, 345.35763479927334, 355.4082452716228, 356.8064823166508, 5360.624756267063, 5393.865153371163, 5410.6724364515785, 5411.512963833255, 5423.566114710824, 5080.136376815941, 5147.794088236466, 5193.3248677671945, 5253.8949221015555, 5357.598180136486, 4250.319948808191, 4261.318189089746, 4268.295731204347, 4272.252355837732, 4282.336237883125, 4251.383549385338, 4251.533221038737, 4273.465816772903, 4273.615374616299, 4275.935860962088, 3982.661473774718, 4014.478117844676, 4196.139791342783, 4218.599233072853, 4228.217779710763, 4224.38746381776, 4240.724352917051, 4243.215005224012, 4243.533211346749, 4245.787710614472, 3788.45067465216, 3802.923941521154, 3806.745232825949, 3818.3890577507464, 3828.349180639298, 5002.424721157041, 5168.896622067575, 5185.585153187736, 5219.634625576211, 5232.1628539433505, 4793.3049707792525, 4814.879628009293, 4823.493533179036, 4825.083234185494, 4844.927326090112, 5544.2063044118995, 5550.611457197998, 5561.0, 5588.413216612278, 5589.776408943638, 3871.922561548753, 4068.125353049079, 4102.528209255944, 4168.854090106862, 4194.182134483777, 5810.518317828969, 5815.912761308584, 5824.4466775656665, 5827.941720582782, 5857.502112320415, 4212.473440819897, 4214.894627634334, 4219.97890010548, 4220.198162349144, 4222.725522841067, 4150.398192262105, 4161.146964872194, 4229.365595160751, 4254.361845723104, 4264.466941632296, 4749.121412538691, 4754.667173297905, 4761.809527618926, 4774.0, 4794.232922732346, 5632.324121105494, 5634.239377684042, 5641.351244606841, 5647.548196144298, 5651.265335506358, 1401.4044031286867, 1419.9574012779633, 1433.3693175002966, 1436.2100844535673, 1441.2865631512468, 914.881065461499, 935.1163150822407, 963.9277054220961, 973.026973026973, 976.2873102635116, 5218.817341393033, 5224.9738751306, 5226.97386513065, 5227.634065615446, 5231.9476805232225, 5533.612647114664, 5542.63972841764, 5549.861253468695, 5552.611317207838, 5552.890381386436, 5049.368828896388, 5160.819371322061, 5175.741212939338, 5196.636235463557, 5233.4243233244315, 2935.9412811743646, 2940.6765255821842, 2960.4753551920776, 2970.85145742712, 2973.2715484706387, 5496.251650021122, 5734.254546908875, 5794.333651630032, 5807.0998995155815, 5810.360860305363, 5644.996026410648, 5647.830565083054, 5649.694928466811, 5666.6116801383105, 5713.228714123623, 5703.574106473382, 5714.9142762857755, 5722.456366645162, 5730.538712628253, 5733.913991290134, 5299.735013249399, 5480.6437581557075, 5495.972520137374, 5514.503694667499, 5526.557875370041, 5401.675899446046, 5454.127339625641, 5461.641090729252, 5463.945360546344, 5465.371482279589, 5419.945800542102, 5703.800366987136, 5706.433479075577, 5724.627899186539, 5768.451997060272, 4003.559608443011, 4031.959680403276, 4047.2310261050307, 4048.149888523443, 4050.0279932815324, 5538.0, 5543.667379957215, 5558.888822223452, 5581.772010157759, 5583.69289689071, 5293.338332708411, 5389.353277606712, 5446.455354464521, 5457.290552228185, 5476.3702174250475, 5593.524550413098, 5626.971865140648, 5628.774849005994, 5654.180143879197, 5654.943450565606, 5366.275552800322, 5515.972420137874, 5632.746526406403, 5632.831015069554, 5649.4633009864, 5511.775611267453, 5662.66024038559, 5671.298610416941, 5676.432356764456, 5691.4877661010705, 5515.25544051564, 5522.420145884625, 5531.0, 5534.584906132137, 5547.2511210986], "value": 4249.840227804145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.7834328044871, 754.4077898849405, 791.0744429018052, 816.5223344343559, 842.4145219072745, 14060.29698515074, 14426.278686065682, 14951.700965980674, 15049.322780474877, 15209.391624335041, 14082.859171408283, 14378.06542574732, 14405.855941440583, 14406.063605865611, 14408.35162417691, 814.100419036963, 824.5547404401616, 841.2807049972278, 846.7036537211989, 857.5540718826206, 855.3456605696647, 856.8800367948493, 857.9485230886136, 859.8409294280547, 860.3676297921023, 890.4568213389826, 891.61660485991, 892.3084609427681, 892.8883889513811, 893.3746377535751, 884.6328773558965, 886.3751055505885, 886.6409104312763, 886.866969954512, 887.3034667785789, 654.7773756922669, 654.9770758023494, 655.0828839624563, 655.1450357283743, 655.4854439265154, 14696.412143514246, 14723.411063557445, 15203.163825989566, 15209.923950380176, 15221.61945951349, 14010.719785604231, 14561.126332420088, 14686.412543498247, 14714.926425367805, 14804.481843135438, 11721.70695732605, 11751.177417580773, 11761.823572646417, 11774.705632359173, 11813.40932953349, 3664.560252769658, 3707.610700876396, 3770.792606406674, 3775.4336849472525, 3792.4121761126794, 65173.674131629035, 67478.0, 67583.32416675819, 67717.66141169312, 68908.3109168907, 10914.672559823219, 10922.235443518877, 11089.778204436028, 11315.773684526428, 11407.201495895208, 20763.896180519303, 20798.168073277204, 20837.79162208389, 20908.0, 21186.576268474546, 7706.7687969361, 7764.883526747103, 7843.0, 7879.093904200976, 8220.095789463154, 4325.3728209409455, 4345.217860785089, 4345.587169218919, 4484.573965473275, 4610.976945115253, 3440.2431465077643, 3553.6091029986683, 3559.0, 3596.226811235597, 3627.165751877083, 571.8541771848236, 592.1768741449389, 630.6279295215845, 655.354475841296, 671.835400326923, 637.8596708724074, 690.4096997067435, 706.9363757261871, 719.6006216549865, 733.812877716179, 8952.552372381355, 9085.049629636964, 9292.0, 9474.431534107976, 9565.043495650518, 611.8317462697705, 657.7927952694886, 660.9457914626164, 740.8110931712379, 767.6622286194169, 4111.239420707119, 4222.852200172979, 4225.218334608107, 4231.4710661167355, 4343.478782546052, 90056.0, 91460.0, 93731.0, 95479.52260238654, 96621.5168924151, 44922.0, 61684.0, 79136.0, 79862.0, 82870.0, 62151.378486215464, 76253.61873190598, 76338.61830690812, 77311.99999999888, 77854.22145778582, 8983.910160898307, 9173.908260917306, 9272.490013049348, 9406.858897116412, 9484.33609647318, 47465.0, 47538.52461475341, 48346.5165348342, 48584.51415485941, 49394.259086113016, 56861.715691421276, 61866.0, 68640.0, 69125.30874691189, 71139.64430178022, 12562.246265224116, 12662.493500260254, 12816.782405671447, 13037.15258508194, 13315.400806963517, 13246.933765331112, 13440.596782096552, 13934.930325348309, 14096.577102686935, 14729.92635036818, 12652.43064062101, 13197.472101115847, 13368.598942031755, 13503.729925401634, 13810.378532966242, 12697.055841599935, 13252.602421927357, 13479.326033698471, 13703.794443083561, 14122.929385353007, 12966.870331296566, 13723.725525489235, 13888.513902013381, 14140.50508232207, 14628.707425851637, 9581.281403894596, 9763.75590610212, 10026.69919902404, 10142.290039697446, 10691.198160137865, 9433.198178154933, 10106.494675266355, 10262.384256944608, 10643.467826608794, 11148.721281968015], "value": 7240.335108557665, "unit": "score"}], "name": "dromaeo_css", "value": 7322.400291402076, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 110.0, 110.0, 111.0, 108.0, 110.0, 110.0, 111.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 117.0, 118.0, 145.0, 121.0, 118.0, 120.0, 118.0, 151.0, 119.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 162.0, 160.0, 161.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 76.0, 77.0, 75.0, 75.0, 97.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 108.0, 82.0, 82.0, 81.0, 97.0, 81.0, 81.0, 117.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 52.0, 50.0, 49.0, 50.0, 52.0, 50.0, 52.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 58.0, 58.0, 58.0, 57.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 80.0, 75.0, 76.0, 75.0, 75.0, 74.0, 76.0, 74.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 123.0, 131.0, 121.0, 122.0, 129.0, 123.0, 177.0, 120.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 157.0, 155.0, 158.0, 155.0, 160.0, 156.0, 159.0, 156.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 63.0, 61.0, 63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1451.1000000000001, "alertThreshold": 2.0}]} 08:40:37 INFO - Return code: 0 08:40:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:40:38 INFO - # TBPL SUCCESS # 08:40:38 INFO - Running post-action listener: _resource_record_post_action 08:40:38 INFO - [mozharness: 2016-12-14 16:40:38.039474Z] Finished run-tests step (success) 08:40:38 INFO - Running post-run listener: _resource_record_post_run 08:40:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 374812672; Read time: 248; Write time: 209760 08:40:38 INFO - TinderboxPrint: CPU usage
13.0% 08:40:38 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 248 08:40:38 INFO - TinderboxPrint: I/O write bytes / time
374,812,672 / 209,760 08:40:38 INFO - TinderboxPrint: CPU idle
8,269.7 (87.0%) 08:40:38 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 08:40:38 INFO - TinderboxPrint: Swap in / out
0 / 0 08:40:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 124059648; Read time: 32; Write time: 77884 08:40:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 249479168; Read time: 200; Write time: 131840 08:40:38 INFO - Running post-run listener: _upload_blobber_files 08:40:38 INFO - Blob upload gear active. 08:40:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:40:38 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 08:40:38 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:40:38 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:40:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:40:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:40:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:40 INFO - (blobuploader) - INFO - Done attempting. 08:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:40:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:40 INFO - (blobuploader) - INFO - Done attempting. 08:40:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:40:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:40:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:40:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:40:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:40:44 INFO - (blobuploader) - INFO - Done attempting. 08:40:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:40:44 INFO - Return code: 0 08:40:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:40:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:40:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa3e857487258bbca92ac793c805316517166229018d37d475fba9fd972fe55d5c36fb52ca192f887b3a48548d210e95834d424274c6278284be8c6a85207155", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af9681a35995a99fef374d41ab8f0f8a5d5397d951026328dc618804f9926f97efb7661c37ab028df942f7d2765f0a1db29518657f3ce7b7a4cb1e7093b6c3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674ea2b92e6b3ea9cda19b6242fd4ff37bf5df0aa5bb67fa2974056e2a6b0ac8057f013e218770ed7bbb48e47d75538ac5b1902447d56fd3684d3912c2e27c73"} 08:40:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:40:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:40:44 INFO - Contents: 08:40:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa3e857487258bbca92ac793c805316517166229018d37d475fba9fd972fe55d5c36fb52ca192f887b3a48548d210e95834d424274c6278284be8c6a85207155", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af9681a35995a99fef374d41ab8f0f8a5d5397d951026328dc618804f9926f97efb7661c37ab028df942f7d2765f0a1db29518657f3ce7b7a4cb1e7093b6c3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674ea2b92e6b3ea9cda19b6242fd4ff37bf5df0aa5bb67fa2974056e2a6b0ac8057f013e218770ed7bbb48e47d75538ac5b1902447d56fd3684d3912c2e27c73"} 08:40:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:40:44 INFO - Copying logs to upload dir... 08:40:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:40:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.591832 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-14 08:40:44.049031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:40:44.052447) ========= 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-1481727900.9260-229739750 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-Aurora/sha512/aa3e857487258bbca92ac793c805316517166229018d37d475fba9fd972fe55d5c36fb52ca192f887b3a48548d210e95834d424274c6278284be8c6a85207155", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af9681a35995a99fef374d41ab8f0f8a5d5397d951026328dc618804f9926f97efb7661c37ab028df942f7d2765f0a1db29518657f3ce7b7a4cb1e7093b6c3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674ea2b92e6b3ea9cda19b6242fd4ff37bf5df0aa5bb67fa2974056e2a6b0ac8057f013e218770ed7bbb48e47d75538ac5b1902447d56fd3684d3912c2e27c73"} build_url:https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/T7sEP-YDTbO4FM-JOxoDJg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aa3e857487258bbca92ac793c805316517166229018d37d475fba9fd972fe55d5c36fb52ca192f887b3a48548d210e95834d424274c6278284be8c6a85207155", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1af9681a35995a99fef374d41ab8f0f8a5d5397d951026328dc618804f9926f97efb7661c37ab028df942f7d2765f0a1db29518657f3ce7b7a4cb1e7093b6c3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/674ea2b92e6b3ea9cda19b6242fd4ff37bf5df0aa5bb67fa2974056e2a6b0ac8057f013e218770ed7bbb48e47d75538ac5b1902447d56fd3684d3912c2e27c73"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-14 08:40:44.077468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:40:44.077810) ========= 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-1481727900.9260-229739750 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-14 08:40:44.160063) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:40:44.160423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-14 08:40:44.160802) ========= ========= Total master_lag: 0.17 =========