builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1476409256.08 results: success (0) buildid: 20161013153005 builduid: e49df5bc221b41dea30f5fda3b87b7a1 revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.083297) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.084399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.085137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.100564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.101023) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 18:40:56-- 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% 224M=0s 2016-10-13 18:40:56 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124103 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.243798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.244512) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013159 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.297252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:56.298072) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 183b9d08d2648d4ed50fa1d354b50bd43c11a891 --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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 18:40:56,712 truncating revision to first 12 chars 2016-10-13 18:40:56,712 Setting DEBUG logging. 2016-10-13 18:40:56,712 attempt 1/10 2016-10-13 18:40:56,713 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/183b9d08d264?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 18:40:57,076 unpacking tar archive at: fx-team-183b9d08d264/testing/mozharness/ program finished with exit code 0 elapsedTime=0.711163 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:57.028498) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:57.029402) ========= script_repo_revision: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:57.030414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:57.031100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 18:40:57.043038) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-13 18:40:57.043353) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:40:57 INFO - MultiFileLogger online at 20161013 18:40:57 in /builds/slave/test 18:40:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:40:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:40:57 INFO - {'append_to_log': False, 18:40:57 INFO - 'base_work_dir': '/builds/slave/test', 18:40:57 INFO - 'blob_upload_branch': 'Fx-Team', 18:40:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:40:57 INFO - 'branch': 'Fx-Team', 18:40:57 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:57 INFO - 'config_files': ('talos/linux_config.py',), 18:40:57 INFO - 'default_actions': ('clobber', 18:40:57 INFO - 'read-buildbot-config', 18:40:57 INFO - 'download-and-extract', 18:40:57 INFO - 'populate-webroot', 18:40:57 INFO - 'create-virtualenv', 18:40:57 INFO - 'install', 18:40:57 INFO - 'run-tests'), 18:40:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:57 INFO - 'download_minidump_stackwalk': True, 18:40:57 INFO - 'download_symbols': 'ondemand', 18:40:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:57 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:57 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:57 INFO - 'installer_path': 'installer.exe', 18:40:57 INFO - 'log_level': 'info', 18:40:57 INFO - 'log_name': 'talos', 18:40:57 INFO - 'log_to_console': True, 18:40:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:40:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:40:57 INFO - 'opt_config_files': (), 18:40:57 INFO - 'pip_index': False, 18:40:57 INFO - 'sps_profile': False, 18:40:57 INFO - 'sps_profile_interval': 0, 18:40:57 INFO - 'suite': 'dromaeojs', 18:40:57 INFO - 'system_bits': '32', 18:40:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:57 INFO - 'title': 'talos-linux64-ix-023', 18:40:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:57 INFO - 'use_talos_json': True, 18:40:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:40:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:57 INFO - 'work_dir': 'build'} 18:40:57 INFO - [mozharness: 2016-10-14 01:40:57.558202Z] Running clobber step. 18:40:57 INFO - Running pre-action listener: _resource_record_pre_action 18:40:57 INFO - Running main action method: clobber 18:40:57 INFO - rmtree: /builds/slave/test/build 18:40:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:40:58 INFO - Running post-action listener: _resource_record_post_action 18:40:58 INFO - [mozharness: 2016-10-14 01:40:58.056263Z] Finished clobber step (success) 18:40:58 INFO - [mozharness: 2016-10-14 01:40:58.056365Z] Running read-buildbot-config step. 18:40:58 INFO - Running pre-action listener: _resource_record_pre_action 18:40:58 INFO - Running main action method: read_buildbot_config 18:40:58 INFO - Using buildbot properties: 18:40:58 INFO - { 18:40:58 INFO - "project": "", 18:40:58 INFO - "product": "firefox", 18:40:58 INFO - "script_repo_revision": "production", 18:40:58 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:40:58 INFO - "repository": "", 18:40:58 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 18:40:58 INFO - "buildid": "20161013153005", 18:40:58 INFO - "pgo_build": "True", 18:40:58 INFO - "basedir": "/builds/slave/test", 18:40:58 INFO - "buildnumber": 1129, 18:40:58 INFO - "slavename": "talos-linux64-ix-023", 18:40:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:40:58 INFO - "platform": "ubuntu64_hw", 18:40:58 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:40:58 INFO - "branch": "fx-team", 18:40:58 INFO - "repo_path": "integration/fx-team", 18:40:58 INFO - "revision": "183b9d08d2648d4ed50fa1d354b50bd43c11a891", 18:40:58 INFO - "stage_platform": "linux64-pgo", 18:40:58 INFO - "builduid": "e49df5bc221b41dea30f5fda3b87b7a1", 18:40:58 INFO - "slavebuilddir": "test" 18:40:58 INFO - } 18:40:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:40:58 INFO - Running post-action listener: _resource_record_post_action 18:40:58 INFO - [mozharness: 2016-10-14 01:40:58.058762Z] Finished read-buildbot-config step (success) 18:40:58 INFO - [mozharness: 2016-10-14 01:40:58.058849Z] Running download-and-extract step. 18:40:58 INFO - Running pre-action listener: _resource_record_pre_action 18:40:58 INFO - Running main action method: download_and_extract 18:40:58 INFO - mkdir: /builds/slave/test/build/tests 18:40:58 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')]} 18:40:58 INFO - trying https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:40:58 INFO - Downloading https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:40:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:40:58 INFO - Downloaded 1361 bytes. 18:40:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:40:58 INFO - Using the following test package requirements: 18:40:58 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:58 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:40:58 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:40:58 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'jsshell-linux-x86_64.zip'], 18:40:58 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:40:58 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:40:58 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:40:58 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:40:58 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:40:58 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:40:58 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:40:58 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:40:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:40:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:40:58 INFO - Fetch https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:40:59 INFO - Http code: 200 18:40:59 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 18:40:59 INFO - x-amz-cf-id: 8QdWXGjH62xdpVzrI567X_QiHSw90lx9_VT4IFManAQM9xCBosatZA== 18:40:59 INFO - x-amz-version-id: qfu3KiVeMxA_0tc_bOr4kG9TvIfpvab3 18:40:59 INFO - Expected file size: 22120825 18:40:59 INFO - Obtained file size: 22120825 18:41:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:41:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:41:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:41:03 INFO - Fetch https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:41:04 INFO - Http code: 200 18:41:04 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 18:41:04 INFO - x-amz-cf-id: V7h7vUW3dSdGh_y22otwBL_4zvcs7vssDW4aMk_XNNDvOO9DSRQc0A== 18:41:04 INFO - x-amz-version-id: qfu3KiVeMxA_0tc_bOr4kG9TvIfpvab3 18:41:04 INFO - Expected file size: 22120825 18:41:04 INFO - Obtained file size: 22120825 18:41:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:41:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:41:08 INFO - Fetch https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:41:09 INFO - Http code: 200 18:41:09 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 18:41:09 INFO - x-amz-cf-id: 8KxY7nzrD07wtyJ7-sTLf7-6pRMr_bh2WB_dzJFE_wRe4AZAAm2Ldg== 18:41:09 INFO - x-amz-version-id: h1k7hnkmOav8ttF1CIX36vcGxBJ1zFX7 18:41:09 INFO - Expected file size: 14409006 18:41:09 INFO - Obtained file size: 14409006 18:41: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')]} 18:41:09 INFO - trying https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:09 INFO - Downloading https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:41:11 INFO - Downloaded 59812107 bytes. 18:41:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:11 INFO - mkdir: /builds/slave/test/properties 18:41:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:41:11 INFO - Writing to file /builds/slave/test/properties/build_url 18:41:11 INFO - Contents: 18:41:11 INFO - build_url:https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:41:11 INFO - Running post-action listener: _resource_record_post_action 18:41:11 INFO - Running post-action listener: set_extra_try_arguments 18:41:11 INFO - [mozharness: 2016-10-14 01:41:11.949477Z] Finished download-and-extract step (success) 18:41:11 INFO - [mozharness: 2016-10-14 01:41:11.949702Z] Running populate-webroot step. 18:41:11 INFO - Running pre-action listener: _resource_record_pre_action 18:41:11 INFO - Running main action method: populate_webroot 18:41:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:41:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:41:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:41:11 INFO - '--tppagecycles', 18:41:11 INFO - '7'], 18:41:11 INFO - 'tests': ['tsvgm']}}, 18:41:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:41:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:41:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:41:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:41:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:41:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['damp', 'tps']}, 18:41:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'tests': ['damp', 'tps']}, 18:41:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['dromaeo_dom']}, 18:41:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:41:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['basic_compositor_video']}, 18:41:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:41:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'other-e10s': {'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['a11yr', 18:41:11 INFO - 'ts_paint', 18:41:11 INFO - 'tpaint', 18:41:11 INFO - 'sessionrestore', 18:41:11 INFO - 'sessionrestore_no_auto_restore', 18:41:11 INFO - 'tabpaint']}, 18:41:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['tsvgx', 18:41:11 INFO - 'tsvgr_opacity', 18:41:11 INFO - 'tart', 18:41:11 INFO - 'tscrollx', 18:41:11 INFO - 'cart']}, 18:41:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:41:11 INFO - 'tsvgr_opacity', 18:41:11 INFO - 'tart', 18:41:11 INFO - 'tscrollx', 18:41:11 INFO - 'cart']}, 18:41:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'talos_options': ['--disable-e10s'], 18:41:11 INFO - 'tests': ['tp5o']}, 18:41:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'tests': ['tp5o']}, 18:41:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'talos_options': ['--disable-e10s', 18:41:11 INFO - '--xperf_path', 18:41:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:11 INFO - 'tests': ['tp5n']}, 18:41:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:11 INFO - 'talos_options': ['--xperf_path', 18:41:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:11 INFO - 'tests': ['tp5n']}}, 18:41:11 INFO - 'talos.zip': {'path': '', 18:41:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:11 INFO - Running post-action listener: _resource_record_post_action 18:41:11 INFO - [mozharness: 2016-10-14 01:41:11.971898Z] Finished populate-webroot step (success) 18:41:11 INFO - [mozharness: 2016-10-14 01:41:11.971988Z] Running create-virtualenv step. 18:41:11 INFO - Running pre-action listener: _resource_record_pre_action 18:41:11 INFO - Running main action method: create_virtualenv 18:41:11 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:11 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 18:41:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:41:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:12 INFO - Using real prefix '/usr' 18:41:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:12 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:14 INFO - Installing pip.................done. 18:41:14 INFO - Return code: 0 18:41:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:41:14 INFO - Reading from file tmpfile_stdout 18:41:14 INFO - Output received: 18:41:14 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) 18:41:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:41:14 INFO - Using env: {'DISPLAY': ':0', 18:41:14 INFO - 'HOME': '/home/cltbld', 18:41:14 INFO - 'LANG': 'en_US.UTF-8', 18:41:14 INFO - 'LANGUAGE': 'en_US:en', 18:41:14 INFO - 'LOGNAME': 'cltbld', 18:41:14 INFO - 'MAIL': '/var/mail/cltbld', 18:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:14 INFO - 'MOZ_NO_REMOTE': '1', 18:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:14 INFO - 'NO_EM_RESTART': '1', 18:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:14 INFO - 'PWD': '/builds/slave/test', 18:41:14 INFO - 'SHELL': '/bin/bash', 18:41:14 INFO - 'SHLVL': '1', 18:41:14 INFO - 'TERM': 'linux', 18:41:14 INFO - 'TMOUT': '86400', 18:41:14 INFO - 'USER': 'cltbld', 18:41:14 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:14 INFO - '_': '/tools/buildbot/bin/python'} 18:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:14 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 18:41:14 INFO - Cleaning up... 18:41:14 INFO - Return code: 0 18:41:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:41:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:41:14 INFO - Using env: {'DISPLAY': ':0', 18:41:14 INFO - 'HOME': '/home/cltbld', 18:41:14 INFO - 'LANG': 'en_US.UTF-8', 18:41:14 INFO - 'LANGUAGE': 'en_US:en', 18:41:14 INFO - 'LOGNAME': 'cltbld', 18:41:14 INFO - 'MAIL': '/var/mail/cltbld', 18:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:14 INFO - 'MOZ_NO_REMOTE': '1', 18:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:14 INFO - 'NO_EM_RESTART': '1', 18:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:15 INFO - 'PWD': '/builds/slave/test', 18:41:15 INFO - 'SHELL': '/bin/bash', 18:41:15 INFO - 'SHLVL': '1', 18:41:15 INFO - 'TERM': 'linux', 18:41:15 INFO - 'TMOUT': '86400', 18:41:15 INFO - 'USER': 'cltbld', 18:41:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:15 INFO - '_': '/tools/buildbot/bin/python'} 18:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:15 INFO - Downloading/unpacking psutil>=3.1.1 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:17 INFO - Installing collected packages: psutil 18:41:17 INFO - Running setup.py install for psutil 18:41:17 INFO - building 'psutil._psutil_linux' extension 18:41:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:41:17 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 18:41:17 INFO - building 'psutil._psutil_posix' extension 18:41:17 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 18:41:17 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 18:41:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:17 INFO - Successfully installed psutil 18:41:17 INFO - Cleaning up... 18:41:17 INFO - Return code: 0 18:41:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:41:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:41:17 INFO - Using env: {'DISPLAY': ':0', 18:41:17 INFO - 'HOME': '/home/cltbld', 18:41:17 INFO - 'LANG': 'en_US.UTF-8', 18:41:17 INFO - 'LANGUAGE': 'en_US:en', 18:41:17 INFO - 'LOGNAME': 'cltbld', 18:41:17 INFO - 'MAIL': '/var/mail/cltbld', 18:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:17 INFO - 'MOZ_NO_REMOTE': '1', 18:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:17 INFO - 'NO_EM_RESTART': '1', 18:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:17 INFO - 'PWD': '/builds/slave/test', 18:41:17 INFO - 'SHELL': '/bin/bash', 18:41:17 INFO - 'SHLVL': '1', 18:41:17 INFO - 'TERM': 'linux', 18:41:17 INFO - 'TMOUT': '86400', 18:41:17 INFO - 'USER': 'cltbld', 18:41:17 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:17 INFO - '_': '/tools/buildbot/bin/python'} 18:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:41:19 INFO - Installing collected packages: mozsystemmonitor 18:41:19 INFO - Running setup.py install for mozsystemmonitor 18:41:20 INFO - Successfully installed mozsystemmonitor 18:41:20 INFO - Cleaning up... 18:41:20 INFO - Return code: 0 18:41:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:41:20 INFO - Using env: {'DISPLAY': ':0', 18:41:20 INFO - 'HOME': '/home/cltbld', 18:41:20 INFO - 'LANG': 'en_US.UTF-8', 18:41:20 INFO - 'LANGUAGE': 'en_US:en', 18:41:20 INFO - 'LOGNAME': 'cltbld', 18:41:20 INFO - 'MAIL': '/var/mail/cltbld', 18:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:20 INFO - 'MOZ_NO_REMOTE': '1', 18:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:20 INFO - 'NO_EM_RESTART': '1', 18:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:20 INFO - 'PWD': '/builds/slave/test', 18:41:20 INFO - 'SHELL': '/bin/bash', 18:41:20 INFO - 'SHLVL': '1', 18:41:20 INFO - 'TERM': 'linux', 18:41:20 INFO - 'TMOUT': '86400', 18:41:20 INFO - 'USER': 'cltbld', 18:41:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:20 INFO - '_': '/tools/buildbot/bin/python'} 18:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:20 INFO - Downloading/unpacking jsonschema==2.5.1 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:41:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:41:22 INFO - warning: no files found matching '*.txt' 18:41:22 INFO - no previously-included directories found matching 'build' 18:41:22 INFO - no previously-included directories found matching 'dist' 18:41:22 INFO - no previously-included directories found matching '.git*' 18:41:22 INFO - Installing collected packages: jsonschema, functools32 18:41:22 INFO - Running setup.py install for functools32 18:41:22 INFO - warning: no files found matching '*.txt' 18:41:22 INFO - no previously-included directories found matching 'build' 18:41:22 INFO - no previously-included directories found matching 'dist' 18:41:22 INFO - no previously-included directories found matching '.git*' 18:41:22 INFO - Successfully installed jsonschema functools32 18:41:22 INFO - Cleaning up... 18:41:22 INFO - Return code: 0 18:41:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:41:22 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')]} 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:22 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')]} 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:22 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:22 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 18:41:22 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 18:41:22 INFO - Using env: {'DISPLAY': ':0', 18:41:22 INFO - 'HOME': '/home/cltbld', 18:41:22 INFO - 'LANG': 'en_US.UTF-8', 18:41:22 INFO - 'LANGUAGE': 'en_US:en', 18:41:22 INFO - 'LOGNAME': 'cltbld', 18:41:22 INFO - 'MAIL': '/var/mail/cltbld', 18:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:22 INFO - 'MOZ_NO_REMOTE': '1', 18:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:22 INFO - 'NO_EM_RESTART': '1', 18:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:22 INFO - 'PWD': '/builds/slave/test', 18:41:22 INFO - 'SHELL': '/bin/bash', 18:41:22 INFO - 'SHLVL': '1', 18:41:22 INFO - 'TERM': 'linux', 18:41:22 INFO - 'TMOUT': '86400', 18:41:22 INFO - 'USER': 'cltbld', 18:41:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:22 INFO - '_': '/tools/buildbot/bin/python'} 18:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:41:22 INFO - Cleaning up... 18:41:22 INFO - Return code: 0 18:41:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41:22 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')]} 18:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:22 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')]} 18:41:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:22 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:22 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 18:41:22 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 18:41:22 INFO - Using env: {'DISPLAY': ':0', 18:41:22 INFO - 'HOME': '/home/cltbld', 18:41:22 INFO - 'LANG': 'en_US.UTF-8', 18:41:22 INFO - 'LANGUAGE': 'en_US:en', 18:41:22 INFO - 'LOGNAME': 'cltbld', 18:41:22 INFO - 'MAIL': '/var/mail/cltbld', 18:41:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:22 INFO - 'MOZ_NO_REMOTE': '1', 18:41:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:22 INFO - 'NO_EM_RESTART': '1', 18:41:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:22 INFO - 'PWD': '/builds/slave/test', 18:41:22 INFO - 'SHELL': '/bin/bash', 18:41:22 INFO - 'SHLVL': '1', 18:41:22 INFO - 'TERM': 'linux', 18:41:22 INFO - 'TMOUT': '86400', 18:41:22 INFO - 'USER': 'cltbld', 18:41:22 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:22 INFO - '_': '/tools/buildbot/bin/python'} 18:41:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:23 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:25 INFO - Downloading docopt-0.6.1.tar.gz 18:41:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:25 INFO - Running setup.py install for blobuploader 18:41:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:25 INFO - Running setup.py install for requests 18:41:26 INFO - Running setup.py install for docopt 18:41:26 INFO - Successfully installed blobuploader requests docopt 18:41:26 INFO - Cleaning up... 18:41:26 INFO - Return code: 0 18:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:26 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:26 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 18:41:26 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 18:41:26 INFO - Using env: {'DISPLAY': ':0', 18:41:26 INFO - 'HOME': '/home/cltbld', 18:41:26 INFO - 'LANG': 'en_US.UTF-8', 18:41:26 INFO - 'LANGUAGE': 'en_US:en', 18:41:26 INFO - 'LOGNAME': 'cltbld', 18:41:26 INFO - 'MAIL': '/var/mail/cltbld', 18:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:26 INFO - 'MOZ_NO_REMOTE': '1', 18:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:26 INFO - 'NO_EM_RESTART': '1', 18:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:26 INFO - 'PWD': '/builds/slave/test', 18:41:26 INFO - 'SHELL': '/bin/bash', 18:41:26 INFO - 'SHLVL': '1', 18:41:26 INFO - 'TERM': 'linux', 18:41:26 INFO - 'TMOUT': '86400', 18:41:26 INFO - 'USER': 'cltbld', 18:41:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:26 INFO - '_': '/tools/buildbot/bin/python'} 18:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:26 INFO - Running setup.py (path:/tmp/pip-Cw6jS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:26 INFO - Running setup.py (path:/tmp/pip-FLJqmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:26 INFO - Running setup.py (path:/tmp/pip-P2t7Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:26 INFO - Running setup.py (path:/tmp/pip-SxDEYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:26 INFO - Running setup.py (path:/tmp/pip-fcEjpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:27 INFO - Running setup.py (path:/tmp/pip-jZ9uUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:27 INFO - Running setup.py (path:/tmp/pip-9qfjg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:27 INFO - Running setup.py (path:/tmp/pip-gikFv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:27 INFO - Running setup.py (path:/tmp/pip-rt_CAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:27 INFO - Running setup.py (path:/tmp/pip-ySUV40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:27 INFO - Running setup.py (path:/tmp/pip-Xi_uYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:27 INFO - Running setup.py (path:/tmp/pip-ZG5vIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:27 INFO - Running setup.py (path:/tmp/pip-eZJAcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:27 INFO - Running setup.py (path:/tmp/pip-7dktpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:27 INFO - Running setup.py (path:/tmp/pip-RgX_gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:27 INFO - Running setup.py (path:/tmp/pip-m5b2b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:27 INFO - Running setup.py (path:/tmp/pip-ivd3RH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:27 INFO - Running setup.py install for manifestparser 18:41:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozcrash 18:41:28 INFO - Running setup.py install for mozdebug 18:41:28 INFO - Running setup.py install for mozdevice 18:41:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozfile 18:41:28 INFO - Running setup.py install for mozhttpd 18:41:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozinfo 18:41:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozInstall 18:41:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for mozleak 18:41:28 INFO - Running setup.py install for mozlog 18:41:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:28 INFO - Running setup.py install for moznetwork 18:41:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozprocess 18:41:29 INFO - Running setup.py install for mozprofile 18:41:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozrunner 18:41:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Running setup.py install for mozscreenshot 18:41:29 INFO - Running setup.py install for moztest 18:41:29 INFO - Running setup.py install for mozversion 18:41:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:29 INFO - Cleaning up... 18:41:29 INFO - Return code: 0 18:41:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:29 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:29 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 18:41:29 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 18:41:29 INFO - Using env: {'DISPLAY': ':0', 18:41:29 INFO - 'HOME': '/home/cltbld', 18:41:29 INFO - 'LANG': 'en_US.UTF-8', 18:41:29 INFO - 'LANGUAGE': 'en_US:en', 18:41:29 INFO - 'LOGNAME': 'cltbld', 18:41:29 INFO - 'MAIL': '/var/mail/cltbld', 18:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:29 INFO - 'MOZ_NO_REMOTE': '1', 18:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:29 INFO - 'NO_EM_RESTART': '1', 18:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:29 INFO - 'PWD': '/builds/slave/test', 18:41:29 INFO - 'SHELL': '/bin/bash', 18:41:29 INFO - 'SHLVL': '1', 18:41:29 INFO - 'TERM': 'linux', 18:41:29 INFO - 'TMOUT': '86400', 18:41:29 INFO - 'USER': 'cltbld', 18:41:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:29 INFO - '_': '/tools/buildbot/bin/python'} 18:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:29 INFO - Running setup.py (path:/tmp/pip-fEw9ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:30 INFO - Running setup.py (path:/tmp/pip-pW8vit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:30 INFO - Running setup.py (path:/tmp/pip-ZU6611-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:30 INFO - Running setup.py (path:/tmp/pip-FxoUnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:30 INFO - Running setup.py (path:/tmp/pip-7xraAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:30 INFO - Running setup.py (path:/tmp/pip-ZJVCgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:30 INFO - Running setup.py (path:/tmp/pip-0tBr6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:30 INFO - Running setup.py (path:/tmp/pip-isNZ30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:30 INFO - Running setup.py (path:/tmp/pip-XzqY3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:30 INFO - Running setup.py (path:/tmp/pip-6Tj0v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:30 INFO - Running setup.py (path:/tmp/pip-nAGiY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:30 INFO - Running setup.py (path:/tmp/pip-JV3eDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:30 INFO - Running setup.py (path:/tmp/pip-nu0Arp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:30 INFO - Running setup.py (path:/tmp/pip-YXhZjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:30 INFO - Running setup.py (path:/tmp/pip-utBsT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:31 INFO - Running setup.py (path:/tmp/pip-iNMYtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:41:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:31 INFO - Running setup.py (path:/tmp/pip-yojo_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:41:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:41:33 INFO - Downloading blessings-1.6.tar.gz 18:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:33 INFO - Installing collected packages: blessings 18:41:33 INFO - Running setup.py install for blessings 18:41:33 INFO - Successfully installed blessings 18:41:33 INFO - Cleaning up... 18:41:33 INFO - Return code: 0 18:41:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:33 INFO - Reading from file tmpfile_stdout 18:41:33 INFO - Current package versions: 18:41:33 INFO - argparse == 1.2.1 18:41:33 INFO - blessings == 1.6 18:41:33 INFO - blobuploader == 1.2.4 18:41:33 INFO - docopt == 0.6.1 18:41:33 INFO - functools32 == 3.2.3-2 18:41:33 INFO - jsonschema == 2.5.1 18:41:33 INFO - manifestparser == 1.1 18:41:33 INFO - mozInstall == 1.12 18:41:33 INFO - mozcrash == 0.17 18:41:33 INFO - mozdebug == 0.1 18:41:33 INFO - mozdevice == 0.48 18:41:33 INFO - mozfile == 1.2 18:41:33 INFO - mozhttpd == 0.7 18:41:33 INFO - mozinfo == 0.9 18:41:33 INFO - mozleak == 0.1 18:41:33 INFO - mozlog == 3.4 18:41:33 INFO - moznetwork == 0.27 18:41:33 INFO - mozprocess == 0.23 18:41:33 INFO - mozprofile == 0.28 18:41:33 INFO - mozrunner == 6.12 18:41:33 INFO - mozscreenshot == 0.1 18:41:33 INFO - mozsystemmonitor == 0.3 18:41:33 INFO - moztest == 0.7 18:41:33 INFO - mozversion == 1.4 18:41:33 INFO - psutil == 3.1.1 18:41:33 INFO - requests == 1.2.3 18:41:33 INFO - wsgiref == 0.1.2 18:41:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:33 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')]} 18:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 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')]} 18:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:33 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 18:41:33 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 18:41:33 INFO - Using env: {'DISPLAY': ':0', 18:41:33 INFO - 'HOME': '/home/cltbld', 18:41:33 INFO - 'LANG': 'en_US.UTF-8', 18:41:33 INFO - 'LANGUAGE': 'en_US:en', 18:41:33 INFO - 'LOGNAME': 'cltbld', 18:41:33 INFO - 'MAIL': '/var/mail/cltbld', 18:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:33 INFO - 'MOZ_NO_REMOTE': '1', 18:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:33 INFO - 'NO_EM_RESTART': '1', 18:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:33 INFO - 'PWD': '/builds/slave/test', 18:41:33 INFO - 'SHELL': '/bin/bash', 18:41:33 INFO - 'SHLVL': '1', 18:41:33 INFO - 'TERM': 'linux', 18:41:33 INFO - 'TMOUT': '86400', 18:41:33 INFO - 'USER': 'cltbld', 18:41:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:33 INFO - '_': '/tools/buildbot/bin/python'} 18:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 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)) 18:41:33 INFO - Cleaning up... 18:41:33 INFO - Return code: 0 18:41:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:41:33 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')]} 18:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 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')]} 18:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 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 0x7ff6f7e56f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19147b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', '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 18:41:33 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 18:41:33 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 18:41:33 INFO - Using env: {'DISPLAY': ':0', 18:41:33 INFO - 'HOME': '/home/cltbld', 18:41:33 INFO - 'LANG': 'en_US.UTF-8', 18:41:33 INFO - 'LANGUAGE': 'en_US:en', 18:41:33 INFO - 'LOGNAME': 'cltbld', 18:41:33 INFO - 'MAIL': '/var/mail/cltbld', 18:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:33 INFO - 'MOZ_NO_REMOTE': '1', 18:41:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:33 INFO - 'NO_EM_RESTART': '1', 18:41:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:33 INFO - 'PWD': '/builds/slave/test', 18:41:33 INFO - 'SHELL': '/bin/bash', 18:41:33 INFO - 'SHLVL': '1', 18:41:33 INFO - 'TERM': 'linux', 18:41:33 INFO - 'TMOUT': '86400', 18:41:33 INFO - 'USER': 'cltbld', 18:41:33 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:33 INFO - '_': '/tools/buildbot/bin/python'} 18:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:41:34 INFO - Cleaning up... 18:41:34 INFO - Return code: 0 18:41:34 INFO - Running post-action listener: _resource_record_post_action 18:41:34 INFO - Running post-action listener: _start_resource_monitoring 18:41:34 INFO - Starting resource monitoring. 18:41:34 INFO - [mozharness: 2016-10-14 01:41:34.089554Z] Finished create-virtualenv step (success) 18:41:34 INFO - [mozharness: 2016-10-14 01:41:34.090029Z] Running install step. 18:41:34 INFO - Running pre-action listener: _resource_record_pre_action 18:41:34 INFO - Running main action method: install 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Output received: 18:41:34 INFO - Usage: mozinstall [options] installer 18:41:34 INFO - Options: 18:41:34 INFO - -h, --help show this help message and exit 18:41:34 INFO - -d DEST, --destination=DEST 18:41:34 INFO - Directory to install application into. [default: 18:41:34 INFO - "/builds/slave/test"] 18:41:34 INFO - --app=APP Application being installed. [default: firefox] 18:41:34 INFO - mkdir: /builds/slave/test/build/application 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:41:51 INFO - Reading from file tmpfile_stdout 18:41:51 INFO - Output received: 18:41:51 INFO - /builds/slave/test/build/application/firefox/firefox 18:41:51 INFO - Running post-action listener: _resource_record_post_action 18:41:51 INFO - [mozharness: 2016-10-14 01:41:51.428372Z] Finished install step (success) 18:41:51 INFO - [mozharness: 2016-10-14 01:41:51.428619Z] Running run-tests step. 18:41:51 INFO - Running pre-action listener: _resource_record_pre_action 18:41:51 INFO - Running main action method: run_tests 18:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:41:51 INFO - Python 2.7.3 18:41:51 INFO - Return code: 0 18:41:51 INFO - grabbing minidump binary from tooltool 18:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:41:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a3790>, '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 0x19a4690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19a4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:41:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:41:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:41:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:41:51 INFO - Return code: 0 18:41:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:41:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:41:51 INFO - Using env: {'DISPLAY': ':0', 18:41:51 INFO - 'HOME': '/home/cltbld', 18:41:51 INFO - 'LANG': 'en_US.UTF-8', 18:41:51 INFO - 'LANGUAGE': 'en_US:en', 18:41:51 INFO - 'LOGNAME': 'cltbld', 18:41:51 INFO - 'MAIL': '/var/mail/cltbld', 18:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:51 INFO - 'MOZ_NO_REMOTE': '1', 18:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:41:51 INFO - 'NO_EM_RESTART': '1', 18:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:51 INFO - 'PWD': '/builds/slave/test', 18:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:41:51 INFO - 'SHELL': '/bin/bash', 18:41:51 INFO - 'SHLVL': '1', 18:41:51 INFO - 'TERM': 'linux', 18:41:51 INFO - 'TMOUT': '86400', 18:41:51 INFO - 'USER': 'cltbld', 18:41:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905', 18:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:51 INFO - '_': '/tools/buildbot/bin/python'} 18:41:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:41:51 INFO - mozversion application_buildid: 20161013153005 18:41:51 INFO - mozversion application_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 18:41:51 INFO - mozversion application_display_name: Nightly 18:41:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:41:51 INFO - mozversion application_name: Firefox 18:41:51 INFO - mozversion application_remotingname: firefox 18:41:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:41:51 INFO - mozversion application_vendor: Mozilla 18:41:51 INFO - mozversion application_version: 52.0a1 18:41:51 INFO - mozversion platform_buildid: 20161013153005 18:41:51 INFO - mozversion platform_changeset: 183b9d08d2648d4ed50fa1d354b50bd43c11a891 18:41:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:41:51 INFO - mozversion platform_version: 52.0a1 18:41:51 INFO - using testdate: 1476409311 18:41:51 INFO - actual date: 1476409311 18:41:51 INFO - starting webserver on 'localhost:38717' 18:41:51 INFO - SUITE-START | Running 2 tests 18:41:51 INFO - TEST-START | dromaeo_css 18:41:51 INFO - operating with platform_type : linux_ 18:41:51 INFO - Initialising browser for dromaeo_css test... 18:41:51 INFO - TEST-INFO | started process 14464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mtuc0/profile http://localhost:38717/getInfo.html) 18:41:55 INFO - PROCESS | 14464 | __metrics Screen width/height:1600/1200 18:41:55 INFO - PROCESS | 14464 | colorDepth:24 18:41:55 INFO - PROCESS | 14464 | Browser inner width/height: 1024/697 18:41:55 INFO - PROCESS | 14464 | __metrics 18:41:56 INFO - PROCESS | 14464 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:41:56 INFO - PROCESS | 14464 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:41:56 INFO - PROCESS | 14464 | console.error: PushService: 18:41:56 INFO - PROCESS | 14464 | stateChangeProcessEnqueue: Error transitioning state 18:41:56 INFO - PROCESS | 14464 | UnknownError 18:41:57 INFO - TEST-INFO | 14464: exit 0 18:41:57 INFO - Browser initialized. 18:41:57 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:57 INFO - TEST-INFO | started process 14547 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8mtuc0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:42:09 INFO - PROCESS | 14547 | RSS: Main: 173191168 18:42:09 INFO - PROCESS | 14547 | 18:43:00 INFO - PROCESS | 14547 | 1476409380829 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] 18:45:11 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38717/tests/dromaeo/cssquery-ext.html) 18:45:13 INFO - PROCESS | 14547 | RSS: Main: 288976896 18:45:13 INFO - PROCESS | 14547 | 18:48:15 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-ext.html (next: http://localhost:38717/tests/dromaeo/cssquery-jquery.html) 18:48:16 INFO - PROCESS | 14547 | RSS: Main: 280911872 18:48:16 INFO - PROCESS | 14547 | 18:51:18 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38717/tests/dromaeo/cssquery-mootools.html) 18:51:19 INFO - PROCESS | 14547 | RSS: Main: 213835776 18:51:19 INFO - PROCESS | 14547 | 18:54:20 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38717/tests/dromaeo/cssquery-prototype.html) 18:54:21 INFO - PROCESS | 14547 | RSS: Main: 256217088 18:54:21 INFO - PROCESS | 14547 | 18:57:24 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38717/tests/dromaeo/cssquery-yui.html) 18:57:25 INFO - PROCESS | 14547 | RSS: Main: 211619840 18:57:25 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | Cycle 1(1): loaded http://localhost:38717/tests/dromaeo/cssquery-yui.html (next: http://localhost:38717/tests/dromaeo/cssquery-dojo.html) 19:00:27 INFO - PROCESS | 14547 | RSS: Main: 305422336 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | __start_tp_report 19:00:27 INFO - PROCESS | 14547 | _x_x_mozilla_page_load 19:00:27 INFO - PROCESS | 14547 | _x_x_mozilla_page_load_details 19:00:27 INFO - PROCESS | 14547 | |i|pagename|runs| 19:00:27 INFO - PROCESS | 14547 | |0;dojo.html;2958.6005889204957;2995.6854530274322;2999.2651800308927;3036.7874248802564;3047.9390412191756;5087.236914462823;5156.974215128924;5190.8442746717565;5236.423993360732;5283.049051170783;5140.049090918183;5159.613029022829;5212.192110222912;5231.476852314776;5262.552683021938;4726.574608285254;4750.501197374278;4797.328374027639;4825.324454576362;4848.53938875808;4820;4865.878353041185;4926.679765815211;4931.038447502739;4987.551120399164;4720.173969555349;4776.904461910777;4781.3545171401765;4817.108834865544;4878.70727756334;4749.24012158053;4835.6131509479155;4835.758212089381;4836.202026665596;4843.22508398658;4773.9761301193275;4794.472608013116;4799.400074990626;4800.951990480085;4803.447603525605;5223.73881305937;5260.92108618371;5283.392409872876;5291.894162116774;5292.867678308035;5607.4112218217315;5611.466910643482;5614.466625670555;5635.915461268084;5642.689652069134;5679.062954612526;5693.715314234271;5693.77224911003;5702.686352250625;5748.5688573357165;5308.389535203424;5346.705931173784;5350.5452036576935;5351.892962140735;5405.864853378618;5575.804846830341;5636.830895073154;5651.067573850269;5683.374828768832;5835.94164058354;5505.779768809202;5512.255845460892;5515.751791169407;5564.554835613141;5578.525825304813;5563.972180139154;5573.136163894603;5576.525995290364;5580.330360356783;5583.022970980062;5404.459554044564;5441.075017247077;5506.256655351476;5566.304211973504;5634.211210430543;5535.750891209906;5609.635373700697;5610.326760788732;5656.85857853557;5661.716914154275;4304.332828411539;4309.461317335333;4310.719803212781;4315.913681726348;4361;3739.9439008414897;3777.225668737902;3830.367989281793;3836.5971572984995;3866.188100498927;5184.455632158644;5196.376434827845;5204.1673332266655;5205.375354957429;5325.068113080196;5662.348829884616;5666.603337766399;5683.772649094072;5685.6304340218585;5693.943060569424;5205.06308864408;5230.660007099526;5242.7378631068295;5247.160454327366;5254.2118682197215;4820.035992801454;4855.247436647254;4864.221724524059;4864.78108485119;4903.362562866804;5667.376588575254;5714.0571805652435;5716.171155182558;5726.455986681259;5795.246617939641;5663.461971112738;5671.489565939085;5671.801486947937;5713.514351280188;5737.110747834093;5715.31416230055;5819.5344372450945;5826.213461182856;5838.0950952600715;5842.561807864512;5271.736413179249;5351.759170837244;5524.530414914777;5541.667499950016;5544.750486228048;5683.77264909399;5758.884822303614;5786.623869448473;5794.449527294901;5795.217645617788;5476.808311709071;5489.39616642161;5490.450954904637;5495.53287970511;5500.917486237629;5428.077226871363;5487.972560137174;5488.451154884479;5489.204065410573;5554.333479982428;5271.446498117796;5311.336082989626;5416.0521908666615;5440.863978400572;5463.125899856004;5537.418571049981;5537.944620553743;5543.334799823886;5545.611807173459;5549.916751248654;5396.244525766474;5421.349438067457;5426.457354264542;5427.077396842467;5482.23248745168 19:00:27 INFO - PROCESS | 14547 | |1;ext.html;555.2617662612374;569.5529009727363;607.5807692692042;609.9695015249239;622.0265284829239;33699;43007.78496107519;44016.11967760643;44066.55933440669;47132.293015604795;45200.773996129974;45460.772696136555;45654.54345456544;45760.54239457604;45788.3131753024;7992.280694737473;8196.795080122985;8858.33562482813;9019.413738107001;9023.503707296097;10410.115140213053;10689.572417103307;10713.08938740208;11031.558737650485;11046.723831904186;10862;10961.83557246642;10965;10965.342079475216;10967.670969870916;8122.862799208116;8303.418760686754;10443.164546836235;10801.945990270038;10892;10293.485325733758;10710.839337409867;10724.302920310232;10731.409772462512;10735.248532602722;42122.78938605318;42438.78780606077;42471;42474.36288455676;42515.14969700589;3487.1630808606005;3518.2611651553207;3586.677199052072;3596.478510615946;3877.515310586177;31179.53230701541;31189.8440507796;31426.842865785526;32052.519212211835;32828.835855820565;4211.305134652778;4266.978665106686;4323.762193079379;4384.539623339567;4403.757793321366;331857;333208;333706;334450;334924.32537837396;57059;57415;57417.712911436014;57476;57548.71225643845;36349.27301453956;37363.813180933925;37411.438828417595;39617.20765584672;39638.801805990784;15882.523524294289;15994.36022559108;16063.678726425405;16068.035917844967;16069.437569685238;11247.212695111428;11261;11786.528538858522;11883.821742673867;11994.220375675728;18312.175952082187;18868.15093320804;18946.43160705181;18978.335758248395;19381.321653742052;7075.5400898942435;7086.468514861406;7109.786706398713;7177.641117944082;7521.849563008709;953.77109493721;1003.4380746781826;1038.948052597367;1045.7281106912105;1120.4957769003981;31385.686143138275;31609.367812643617;31618.209544761565;31934.395557369127;32056.679433205834;1060.5863713151878;1086.766345235778;1105.9170562207705;1107.5846557540922;1162.7325715085578;15981.60045998836;16590.91704541494;16639.41762038323;16655.167241637868;17018.659626807643;530111;532745;535239;535399;537355;56596;57112.71443642755;57167.71416142976;57174.42825571691;57179.71410142923;1182.479708928069;1239.1202246404973;1254.3978890132787;1317.2754984758535;1351.567498400522;31107.68892311048;32375.838120809247;32771;33110.33779324352;33376.83311583426;44255.77872110619;45773.77113114413;46266.30600540927;46900.530994689616;47438.525614744794;381171;383420;384384;384399;385130;26792.59811102796;27948.720512795426;28008.859955700093;29559.26101847385;29769.851150744107;42216.78891605522;43010;43599.78200108979;44311;44431.555684444036;36923.26153476969;38417.4237386445;39783.60216397799;41545.376819347126;43566.78216608897;37303.81348093242;39212.80393598014;39366.606333936295;39987;40136.39795403013;39513.60486395099;40713.79643101884;41026.384604231556;41077.79461102795;41142.38286425646;31268.218294542818;33023.50464743079;33419.66580334165;33455.49816752702;33503.83248083744;27245.318867028484;27794;27890;28020.859895700392;28030 19:00:27 INFO - PROCESS | 14547 | |2;jquery.html;371.4150213413874;381.1861675323184;387.56979752474757;400.4553806822721;418.9895252618686;13233.735325293488;18160.27358905644;18306.26774929003;20168.899155504238;20296.492587685316;18344.724829127576;18378.264869405208;19125;19237.134328955195;19282.61434771304;5425.782968681257;5719.714014299289;5722.198892155102;5724.771009159628;5724.998125328072;5567.610267281292;5588.189712491686;5686.630369026021;5821;5851.210086638313;5920.851978700523;5926.081457374093;5932.911006334908;5934.703264836762;5936.703164841762;5606.131049687285;5849.473547380735;5893.528517718572;5929.110633404981;5984.4613984741145;5641;5767.394423585547;5816.912746308766;5821.27234095738;5829.621074630178;22234.444138896495;22348.553028939492;22556.533825301467;22661;22889.77110228893;2262.8302877284104;2295.36877358726;2321.8374713770045;2393.8324317297797;2425.7331693513697;9945.403275803403;10115.645952391631;10146.615545346838;10350.171986241157;10600.893991060067;1876.5402476393235;1898.2122419196016;1987.4633848860872;1990.4128282156653;2005.2981456490259;54582;72485;72876.63561682211;84482.15517844804;84766.57616711876;10438.895611043792;10766.138708903269;10867.565297388173;10977.506012229469;11009.61466348674;15243.390264389522;15314.770278445832;15322.923385383001;15329.310181041657;15333;7479.887801682979;7612.238776122344;7713.4214933880185;7717.2282771722375;7823.647935842901;7100.289971002859;7161.641917904084;7372.410207183412;7390.29792169743;7433.10802703679;4583;4671.252599584051;4687.7656117194;4836.903261934742;4867.634927380461;1936.3610008697096;1965;2001.909914053871;2011.6278488479677;2016.3446879764135;804.7827086686561;812.7480481050893;821.7411515372758;947.1617618407621;1010.8938561450942;18447.26210951547;19029.714554281698;19066.142023608973;19104.713429298572;19373.612527749367;987.1214618989105;997.0976266478848;1002.9348092373972;1003.7139415266614;1036.8703912011;9980.305317564216;10503.94748026255;10512;10575.20685948557;10596.364218146937;412531;416582;419857.30499432376;420026;437769;91420.5428972851;94243.52878235564;95251;96109.38483519384;100973.49513252387;1021.5964693945998;1024.8872624011353;1067.3329169269207;1068.9144868410508;1069.7806949575318;16635.83364166343;16676.332946681996;17286.394976175772;17557;17781.555461113574;29566;36702.63297367099;36799;41372.37941430941;41641.167176656905;50322.74838625784;50620.49379506305;53391.73304133455;59096.40903590909;62051.52046871343;8030.036395632328;8195.631196596287;8255.298299644597;8512.787180320542;8579.82840343202;8873.778155546162;11813.645590632295;12822.358882056047;12989.545365912149;13074.607761767162;11231.775364492827;11338.14963877729;11565.537378504765;11567.248128871597;11864.76270474603;11406.372649504357;11456.942715286703;11534.250273732516;11537.942310288396;11745.882541174478;11462.426878655868;11508.94245528767;11531.365774882463;11754.412279386168;11882.28706277626;7316.926830731624;7439.2188820173105;7494.6252687366505;7786.844263114819;8721.389502734748;9705.951470242886;11259.380734059705;11375;11483.770324593628;11849.881501185222 19:00:27 INFO - PROCESS | 14547 | |3;mootools.html;1396.6997095624442;1450.6735984403508;1482.770170623553;1699.3405320673146;1699.413702272717;8419.873701894476;9095.54522273887;9099.727008189757;9108.271338292938;9110.544472776368;7632.389408847279;7795.493292935969;7843.058832940041;8079.474834135792;8919.554022298875;2050.28240115959;2130.8401869859745;2181.432827464863;2185.2242453928866;2208.6907832903407;2210.993049452743;2217.2350539063996;2234.1175235781857;2237.071615279657;2240.4510894830787;2193.56128774245;2297.7127859017623;2308.6421604651305;2312.8034117099983;2316.339843144704;2282.8402011859175;2285.2915596165158;2298.816094712419;2304.4584522637165;2308.5729140109133;2257.81937445004;2262.3439202631216;2274.6701728249313;2277.749447560767;2292.323764489463;8218.547979861105;8781.253593444564;8909.109089091104;8930.151635594608;8937.374383793138;5097.1844504879045;5147.279380886679;5193.818216362447;5203.947960520384;5242.79028838846;3259.837008149583;3363.9663603363897;3415.7267418606452;3478.7912725236315;3485.4597537381746;1108.4845546820686;1140.988590114105;1148.7817314710262;1166.3002198680808;1176.4882276209876;12327.075469339836;12391.070669699719;12402.503899843996;12437.689057773538;12453.190542614791;4279.87160385189;4581.266997280419;4593.839215627437;4630.560096790799;4636.211843986463;10410.427426491464;10419.322744021765;10419.374837509622;10428.687139385831;10433.217508686726;5267.9736601316745;5285.339332583427;5288.418273989858;5293.258943747878;5293.470652934753;4710.811567537328;4827.806887724451;4883.34074899891;4883.951160488421;4885.902281954341;3519.1202199450136;3616.9819150904605;3775.3959366501226;3821.9808900955873;3882.5340959084524;1205.722683782735;1209.2563073709605;1211.896988755948;1216.7505661339403;1228.2078059651474;919.1084647891535;921.3504479342048;937.8323986636544;946.2855544064325;959.8032403357295;5618.353889302701;5698.686572238566;5733.971330143406;5973.581849270509;5983.222181116514;893.8569828827357;905.4295793649958;961.293449314753;963.9855402168973;971.455984648599;3728.6271372862498;3774.8867533974026;3905.977540629155;4015.6988225883174;4024.0744628735556;10808;11043.282186657842;11141.721456963478;11165.72085697864;11216.102711783038;10906.781864362669;10930.125589952784;10931.726706832234;11037.337759734442;11112.277701949348;8298.460600060977;8343.249107580468;8360.874586881202;8369.200621866328;8376.832463350698;5590.664560126405;5628.268325117709;5668.2064510967675;5786.566007549535;5862.67755273447;10215;10234.488275586042;10257.640982565574;10296.433696146783;10373.481325933522;10162.288639795439;10182;10345.896541034794;10469.476526173814;10480.213983951082;7873.133955264801;7997.480163789335;7998.880016799869;8006.279434850891;8006.919930800617;7108.822279442848;7557.584332861526;8135.71524996646;8574.31405487547;8645.8703119452;7685.11621163551;7732.536047837148;7798.142204357629;7818.374530037697;7823.295903368724;7361.079865016873;7406.481546291708;7445.739399121005;7481.88777168332;7538.736144234926;6861.416779573592;6874.931250687429;6930.306969303029;6953;7023.859522809617;4911.582515486224;4915.950840491692;4938.358013458227;4974.0797952378925;5059.114654935445;4636.907261854812;4639.791209395653;4694.92957605643;4772.880677983078;4791.712497250176 19:00:27 INFO - PROCESS | 14547 | |4;prototype.html;326.5102346480278;333.44314993960086;338.91696534349074;341.97264218862483;343.4539082858255;5055.797768089281;5205.947940520594;5206.895862082756;5298.08605267103;5339.706316152615;5077.568406685427;5180.740962951847;5203.765830537625;5205.193195054763;5221.503957124077;4157.52188498322;4168.187203495319;4170.937435938464;4178.203372549802;4214.557471465498;3945.842166313344;4074.348104303312;4194.412782210493;4197.677731514578;4198.20234155511;4089;4089.325261331877;4091.8158682859194;4101.507819061717;4103.281925662997;4087.751736544918;4096.32410652242;4098.385242213677;4100.507939047304;4136.896577585554;3650.963490365089;3658.579263384718;3660.3228402745312;3662.1393972416463;3663.102539877747;5024.171011783052;5078.873028174288;5120.615953803443;5120.820771272987;5149.3305870237;4696.497120921306;4724.055188962221;4730.574248317668;4735.644826638016;4739.14695354836;5420.512153906128;5421.810236641738;5451.536619387317;5467.289252397163;5475.890482190334;3810.428435734634;3946.4474973503734;3970.7617542947514;3995.0212198011673;4002.5597184309704;5662.518685911661;5692.146178073281;5703.828885133453;5704.885902281972;5706.172604972256;4063.6952228582973;4079.5920407958965;4104.932717493473;4114.814833332507;4120.21715873983;3907.648311651908;4082.6121518455698;4105.3020986432375;4128.6284234419045;4160.604742549453;4689.835855745033;4691.9912218873105;4694.389729335233;4705.929411058837;4732.526747325309;5520.834374968757;5533.972330138404;5543;5578.721063946787;5584.431161665598;1318.7164759576544;1320.3662242123835;1402.3268830961197;1415.971680566383;1422.8901456863664;874.6763697431991;904.3307952115388;905.4612505559313;913.1234015345343;916.1434059154578;4582.587567118975;4585.945232596521;4609.262517997105;4632.25883858581;4633.258678611406;4913.459519452857;4917.434495033117;4922.58158056562;4928.654994150446;4957.983613359253;4439.756868076944;4600.861974140781;4618.584327410549;4619.491855895849;4635.513271106553;2593.597992311195;2597.9867851537538;2614.9869250653624;2619.3189770659383;2625.9474810503684;4998.151423403959;5033.597312215014;5040.243963405445;5046.798128074909;5048.444671086178;4973.303737476756;4984.77568509418;4989.55094041538;5007.39911210657;5369.4630536946;5853.64878107315;5885.6468611882565;5902.291724993029;5910.970445147918;5926.881462370815;5703.600747947604;5718.256626638677;5731.340895797037;5733.770649173986;5735.254416925773;5456.911639317212;5592.524635406036;5624.718764061862;5643.899439609237;5693.28833895763;5895.700676736162;5896.233489646319;5897.882042359043;5914;5916.26046744157;4099.36459848712;4121.093359460914;4123.463949686641;4134.297169481256;4137.586241375839;5368.32895888014;5553.972230138985;5665.943340566707;5717.942820571741;5723.427657234243;5385.9192112119135;5419.729013549386;5559.972200138974;5601.551875849841;5638.464345887134;5592.692401917933;5612.466815652507;5625.184348269559;5648.943510564842;5653.349864765604;5236.371635403776;5531.225628412106;5534.059209934401;5552.194931734795;5612.354579223442;5573.742634233142;5577.247071645438;5577.972110139423;5580.665160090408;5585.720713964367;5478.164814787091;5493.725313734377;5501.752421140978;5529.972350138223;5547.639403438763 19:00:27 INFO - PROCESS | 14547 | |5;yui.html;791.6991543213579;793.9920600793994;819.9180081991801;827.4952279109739;835.4235577451558;15434.922825385871;16888.07115608641;16911.577210569743;16916.577085572837;16930.915345423273;15319.387224511007;15361.231938403063;15389.846101538982;15411.306491207895;15450;777.428589986361;802.7993001749562;803.2650125135494;803.8311954489565;804.1476035402492;642.4828013449171;652.5530011941811;770.414484991405;804.8028233082903;809.7449303469389;831.3390854270839;837.4054421360842;837.6858677995751;840.3025488844276;842.9662813487453;833.2292629317917;835.0105125426389;835.0939230934443;835.3192148399065;835.6949713354643;501.4809671989473;503.49398854151343;599.2000679093416;617.8300967234002;619.981400557984;14101.435942562286;14993.250337483192;15088.547343579601;15101.546953591409;15113.622159445991;13167.275799831006;13955.651108722263;14042.438302467888;14114.064644951954;14117.505887293895;12269.386530673431;12401.13192076555;12452.252864828139;12454.501819927193;12685.238885666797;4381.738135681368;4412.227860124497;4482.932756008662;4509.774511274456;4544.136614043321;74861.62569187119;76205;76398;77009.22990770076;79721.60139199383;11293.15301352402;11410.600628978113;11447.484863181176;11509.366984815748;11526.88473115275;21610;21623.891880540497;21637.672465506963;21663.783362166178;21848;7953.32396746283;7999.640016199285;8021.358291336679;8024.959875200703;8107.473014254055;4386.078923426053;4413.558644135625;4423.601875831127;4465.1962646723905;4536.750478723702;3507.982460087734;3540.5220295260324;3575.8927232183078;3604.33319835826;3617.529721136288;604.4952464691944;618.523736722721;619.3280290884351;622.0575827621158;633.0757094641782;590.5069267161882;667.609448472649;691.5677701436603;697.1529591546296;705.8517711280689;8539.274161696201;8543.102974187745;8849.557522123869;8908.8663670045;8972;646.9838254043686;650.1742786660914;686.3891136888174;696.979090627282;697.3758486154965;4307.267764480046;4373.2565463871215;4427.911441771211;4436.251367594377;4470.776461176928;70250.64874675593;71261;123483;125724;128005.35997319953;99030.5048474753;102369.48815255876;104033;105656;106251.4687426558;82770;85477.57261213654;86187.64091565818;86950.56524717336;88744.11255887487;8350.331973442231;8385.161483851565;8413.495190288602;8441.91558084436;8544.74365769028;51206;52265.47734522606;53358;53880.46119538754;55800.72099639638;78520;78936.60531697304;79263;81962.59018704869;82071.5896420514;11053.668389948314;11155.358728048794;11217.102631789274;11290.15323850698;11511;12377.814332785196;12425.19236249641;12519.31143787064;12912.483500659868;14891.255437228312;13318.533851315158;13360.465581376637;13382.531611393555;14355.784663229852;15093.849061509245;11100.777984440105;12919.870801292243;13398.531051413154;13643.795343069663;13841.169529828243;13210;13959.371828267549;14154.400780767424;14283.714325713636;14284.287283987946;11045.023791434916;11091.389973551532;11154.442277885912;11488.2687768987;11667.183297169116;11072.280301780358;11160.609378671708;11245.71885702864;11273.154513411362;11582.6525204244 19:00:27 INFO - PROCESS | 14547 | __end_tp_report 19:00:27 INFO - PROCESS | 14547 | __start_cc_report 19:00:27 INFO - PROCESS | 14547 | _x_x_mozilla_cycle_collect,1070 19:00:27 INFO - PROCESS | 14547 | __end_cc_report 19:00:27 INFO - PROCESS | 14547 | __startTimestamp1476410427923__endTimestamp 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | ------- Summary: start ------- 19:00:27 INFO - PROCESS | 14547 | Number of tests: 6 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#0] dojo.html Cycles:165 Average:5220.15 Median:5421.35 stddev:591.83 (10.9%) stddev-sans-first:566.43 19:00:27 INFO - PROCESS | 14547 | Values: 2958.6 2995.7 2999.3 3036.8 3047.9 5087.2 5157.0 5190.8 5236.4 5283.0 5140.0 5159.6 5212.2 5231.5 5262.6 4726.6 4750.5 4797.3 4825.3 4848.5 4820.0 4865.9 4926.7 4931.0 4987.6 4720.2 4776.9 4781.4 4817.1 4878.7 4749.2 4835.6 4835.8 4836.2 4843.2 4774.0 4794.5 4799.4 4801.0 4803.4 5223.7 5260.9 5283.4 5291.9 5292.9 5607.4 5611.5 5614.5 5635.9 5642.7 5679.1 5693.7 5693.8 5702.7 5748.6 5308.4 5346.7 5350.5 5351.9 5405.9 5575.8 5636.8 5651.1 5683.4 5835.9 5505.8 5512.3 5515.8 5564.6 5578.5 5564.0 5573.1 5576.5 5580.3 5583.0 5404.5 5441.1 5506.3 5566.3 5634.2 5535.8 5609.6 5610.3 5656.9 5661.7 4304.3 4309.5 4310.7 4315.9 4361.0 3739.9 3777.2 3830.4 3836.6 3866.2 5184.5 5196.4 5204.2 5205.4 5325.1 5662.3 5666.6 5683.8 5685.6 5693.9 5205.1 5230.7 5242.7 5247.2 5254.2 4820.0 4855.2 4864.2 4864.8 4903.4 5667.4 5714.1 5716.2 5726.5 5795.2 5663.5 5671.5 5671.8 5713.5 5737.1 5715.3 5819.5 5826.2 5838.1 5842.6 5271.7 5351.8 5524.5 5541.7 5544.8 5683.8 5758.9 5786.6 5794.4 5795.2 5476.8 5489.4 5490.5 5495.5 5500.9 5428.1 5488.0 5488.5 5489.2 5554.3 5271.4 5311.3 5416.1 5440.9 5463.1 5537.4 5537.9 5543.3 5545.6 5549.9 5396.2 5421.3 5426.5 5427.1 5482.2 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#1] ext.html Cycles:180 Average:57278.99 Median:3591.58 stddev:112818.03 (3141.2%) stddev-sans-first:113054.12 19:00:27 INFO - PROCESS | 14547 | Values: 555.3 569.6 607.6 610.0 622.0 33699.0 43007.8 44016.1 44066.6 47132.3 45200.8 45460.8 45654.5 45760.5 45788.3 7992.3 8196.8 8858.3 9019.4 9023.5 10410.1 10689.6 10713.1 11031.6 11046.7 10862.0 10961.8 10965.0 10965.3 10967.7 8122.9 8303.4 10443.2 10801.9 10892.0 10293.5 10710.8 10724.3 10731.4 10735.2 42122.8 42438.8 42471.0 42474.4 42515.1 3487.2 3518.3 3586.7 3596.5 3877.5 31179.5 31189.8 31426.8 32052.5 32828.8 4211.3 4267.0 4323.8 4384.5 4403.8 331857.0 333208.0 333706.0 334450.0 334924.3 57059.0 57415.0 57417.7 57476.0 57548.7 36349.3 37363.8 37411.4 39617.2 39638.8 15882.5 15994.4 16063.7 16068.0 16069.4 11247.2 11261.0 11786.5 11883.8 11994.2 18312.2 18868.2 18946.4 18978.3 19381.3 7075.5 7086.5 7109.8 7177.6 7521.8 953.8 1003.4 1038.9 1045.7 1120.5 31385.7 31609.4 31618.2 31934.4 32056.7 1060.6 1086.8 1105.9 1107.6 1162.7 15981.6 16590.9 16639.4 16655.2 17018.7 530111.0 532745.0 535239.0 535399.0 537355.0 56596.0 57112.7 57167.7 57174.4 57179.7 1182.5 1239.1 1254.4 1317.3 1351.6 31107.7 32375.8 32771.0 33110.3 33376.8 44255.8 45773.8 46266.3 46900.5 47438.5 381171.0 383420.0 384384.0 384399.0 385130.0 26792.6 27948.7 28008.9 29559.3 29769.9 42216.8 43010.0 43599.8 44311.0 44431.6 36923.3 38417.4 39783.6 41545.4 43566.8 37303.8 39212.8 39366.6 39987.0 40136.4 39513.6 40713.8 41026.4 41077.8 41142.4 31268.2 33023.5 33419.7 33455.5 33503.8 27245.3 27794.0 27890.0 28020.9 28030.0 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#2] jquery.html Cycles:180 Average:26598.33 Median:15995.87 stddev:69888.99 (436.9%) stddev-sans-first:70057.30 19:00:27 INFO - PROCESS | 14547 | Values: 371.4 381.2 387.6 400.5 419.0 13233.7 18160.3 18306.3 20168.9 20296.5 18344.7 18378.3 19125.0 19237.1 19282.6 5425.8 5719.7 5722.2 5724.8 5725.0 5567.6 5588.2 5686.6 5821.0 5851.2 5920.9 5926.1 5932.9 5934.7 5936.7 5606.1 5849.5 5893.5 5929.1 5984.5 5641.0 5767.4 5816.9 5821.3 5829.6 22234.4 22348.6 22556.5 22661.0 22889.8 2262.8 2295.4 2321.8 2393.8 2425.7 9945.4 10115.6 10146.6 10350.2 10600.9 1876.5 1898.2 1987.5 1990.4 2005.3 54582.0 72485.0 72876.6 84482.2 84766.6 10438.9 10766.1 10867.6 10977.5 11009.6 15243.4 15314.8 15322.9 15329.3 15333.0 7479.9 7612.2 7713.4 7717.2 7823.6 7100.3 7161.6 7372.4 7390.3 7433.1 4583.0 4671.3 4687.8 4836.9 4867.6 1936.4 1965.0 2001.9 2011.6 2016.3 804.8 812.7 821.7 947.2 1010.9 18447.3 19029.7 19066.1 19104.7 19373.6 987.1 997.1 1002.9 1003.7 1036.9 9980.3 10503.9 10512.0 10575.2 10596.4 412531.0 416582.0 419857.3 420026.0 437769.0 91420.5 94243.5 95251.0 96109.4 100973.5 1021.6 1024.9 1067.3 1068.9 1069.8 16635.8 16676.3 17286.4 17557.0 17781.6 29566.0 36702.6 36799.0 41372.4 41641.2 50322.7 50620.5 53391.7 59096.4 62051.5 8030.0 8195.6 8255.3 8512.8 8579.8 8873.8 11813.6 12822.4 12989.5 13074.6 11231.8 11338.1 11565.5 11567.2 11864.8 11406.4 11456.9 11534.3 11537.9 11745.9 11462.4 11508.9 11531.4 11754.4 11882.3 7316.9 7439.2 7494.6 7786.8 8721.4 9706.0 11259.4 11375.0 11483.8 11849.9 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#3] mootools.html Cycles:180 Average:5744.28 Median:4638.35 stddev:3337.40 (72.0%) stddev-sans-first:3330.77 19:00:27 INFO - PROCESS | 14547 | Values: 1396.7 1450.7 1482.8 1699.3 1699.4 8419.9 9095.5 9099.7 9108.3 9110.5 7632.4 7795.5 7843.1 8079.5 8919.6 2050.3 2130.8 2181.4 2185.2 2208.7 2211.0 2217.2 2234.1 2237.1 2240.5 2193.6 2297.7 2308.6 2312.8 2316.3 2282.8 2285.3 2298.8 2304.5 2308.6 2257.8 2262.3 2274.7 2277.7 2292.3 8218.5 8781.3 8909.1 8930.2 8937.4 5097.2 5147.3 5193.8 5203.9 5242.8 3259.8 3364.0 3415.7 3478.8 3485.5 1108.5 1141.0 1148.8 1166.3 1176.5 12327.1 12391.1 12402.5 12437.7 12453.2 4279.9 4581.3 4593.8 4630.6 4636.2 10410.4 10419.3 10419.4 10428.7 10433.2 5268.0 5285.3 5288.4 5293.3 5293.5 4710.8 4827.8 4883.3 4884.0 4885.9 3519.1 3617.0 3775.4 3822.0 3882.5 1205.7 1209.3 1211.9 1216.8 1228.2 919.1 921.4 937.8 946.3 959.8 5618.4 5698.7 5734.0 5973.6 5983.2 893.9 905.4 961.3 964.0 971.5 3728.6 3774.9 3906.0 4015.7 4024.1 10808.0 11043.3 11141.7 11165.7 11216.1 10906.8 10930.1 10931.7 11037.3 11112.3 8298.5 8343.2 8360.9 8369.2 8376.8 5590.7 5628.3 5668.2 5786.6 5862.7 10215.0 10234.5 10257.6 10296.4 10373.5 10162.3 10182.0 10345.9 10469.5 10480.2 7873.1 7997.5 7998.9 8006.3 8006.9 7108.8 7557.6 8135.7 8574.3 8645.9 7685.1 7732.5 7798.1 7818.4 7823.3 7361.1 7406.5 7445.7 7481.9 7538.7 6861.4 6874.9 6930.3 6953.0 7023.9 4911.6 4916.0 4938.4 4974.1 5059.1 4636.9 4639.8 4694.9 4772.9 4791.7 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#4] prototype.html Cycles:180 Average:4553.50 Median:5028.88 stddev:1344.31 (26.7%) stddev-sans-first:1310.11 19:00:27 INFO - PROCESS | 14547 | Values: 326.5 333.4 338.9 342.0 343.5 5055.8 5205.9 5206.9 5298.1 5339.7 5077.6 5180.7 5203.8 5205.2 5221.5 4157.5 4168.2 4170.9 4178.2 4214.6 3945.8 4074.3 4194.4 4197.7 4198.2 4089.0 4089.3 4091.8 4101.5 4103.3 4087.8 4096.3 4098.4 4100.5 4136.9 3651.0 3658.6 3660.3 3662.1 3663.1 5024.2 5078.9 5120.6 5120.8 5149.3 4696.5 4724.1 4730.6 4735.6 4739.1 5420.5 5421.8 5451.5 5467.3 5475.9 3810.4 3946.4 3970.8 3995.0 4002.6 5662.5 5692.1 5703.8 5704.9 5706.2 4063.7 4079.6 4104.9 4114.8 4120.2 3907.6 4082.6 4105.3 4128.6 4160.6 4689.8 4692.0 4694.4 4705.9 4732.5 5520.8 5534.0 5543.0 5578.7 5584.4 1318.7 1320.4 1402.3 1416.0 1422.9 874.7 904.3 905.5 913.1 916.1 4582.6 4585.9 4609.3 4632.3 4633.3 4913.5 4917.4 4922.6 4928.7 4958.0 4439.8 4600.9 4618.6 4619.5 4635.5 2593.6 2598.0 2615.0 2619.3 2625.9 4998.2 5033.6 5040.2 5046.8 5048.4 4973.3 4984.8 4989.6 5007.4 5369.5 5853.6 5885.6 5902.3 5911.0 5926.9 5703.6 5718.3 5731.3 5733.8 5735.3 5456.9 5592.5 5624.7 5643.9 5693.3 5895.7 5896.2 5897.9 5914.0 5916.3 4099.4 4121.1 4123.5 4134.3 4137.6 5368.3 5554.0 5665.9 5717.9 5723.4 5385.9 5419.7 5560.0 5601.6 5638.5 5592.7 5612.5 5625.2 5648.9 5653.3 5236.4 5531.2 5534.1 5552.2 5612.4 5573.7 5577.2 5578.0 5580.7 5585.7 5478.2 5493.7 5501.8 5530.0 5547.6 19:00:27 INFO - PROCESS | 14547 | 19:00:27 INFO - PROCESS | 14547 | [#5] yui.html Cycles:180 Average:20727.69 Median:4450.72 stddev:30083.59 (675.9%) stddev-sans-first:30130.74 19:00:27 INFO - PROCESS | 14547 | Values: 791.7 794.0 819.9 827.5 835.4 15434.9 16888.1 16911.6 16916.6 16930.9 15319.4 15361.2 15389.8 15411.3 15450.0 777.4 802.8 803.3 803.8 804.1 642.5 652.6 770.4 804.8 809.7 831.3 837.4 837.7 840.3 843.0 833.2 835.0 835.1 835.3 835.7 501.5 503.5 599.2 617.8 620.0 14101.4 14993.3 15088.5 15101.5 15113.6 13167.3 13955.7 14042.4 14114.1 14117.5 12269.4 12401.1 12452.3 12454.5 12685.2 4381.7 4412.2 4482.9 4509.8 4544.1 74861.6 76205.0 76398.0 77009.2 79721.6 11293.2 11410.6 11447.5 11509.4 11526.9 21610.0 21623.9 21637.7 21663.8 21848.0 7953.3 7999.6 8021.4 8025.0 8107.5 4386.1 4413.6 4423.6 4465.2 4536.8 3508.0 3540.5 3575.9 3604.3 3617.5 604.5 618.5 619.3 622.1 633.1 590.5 667.6 691.6 697.2 705.9 8539.3 8543.1 8849.6 8908.9 8972.0 647.0 650.2 686.4 697.0 697.4 4307.3 4373.3 4427.9 4436.3 4470.8 70250.6 71261.0 123483.0 125724.0 128005.4 99030.5 102369.5 104033.0 105656.0 106251.5 82770.0 85477.6 86187.6 86950.6 88744.1 8350.3 8385.2 8413.5 8441.9 8544.7 51206.0 52265.5 53358.0 53880.5 55800.7 78520.0 78936.6 79263.0 81962.6 82071.6 11053.7 11155.4 11217.1 11290.2 11511.0 12377.8 12425.2 12519.3 12912.5 14891.3 13318.5 13360.5 13382.5 14355.8 15093.8 11100.8 12919.9 13398.5 13643.8 13841.2 13210.0 13959.4 14154.4 14283.7 14284.3 11045.0 11091.4 11154.4 11488.3 11667.2 11072.3 11160.6 11245.7 11273.2 11582.7 19:00:27 INFO - PROCESS | 14547 | -------- Summary: end -------- 19:00:27 INFO - PROCESS | 14547 | 19:00:28 INFO - TEST-INFO | 14547: exit 0 19:00:28 INFO - TEST-OK | dromaeo_css | took 1117156ms 19:00:28 INFO - TEST-START | kraken 19:00:28 INFO - operating with platform_type : linux_ 19:00:28 INFO - Initialising browser for kraken test... 19:00:28 INFO - TEST-INFO | started process 14854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTq2oy_/profile http://localhost:38717/getInfo.html) 19:00:32 INFO - PROCESS | 14854 | __metrics Screen width/height:1600/1200 19:00:32 INFO - PROCESS | 14854 | colorDepth:24 19:00:32 INFO - PROCESS | 14854 | Browser inner width/height: 1024/697 19:00:32 INFO - PROCESS | 14854 | __metrics 19:00:33 INFO - PROCESS | 14854 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:00:33 INFO - PROCESS | 14854 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:00:33 INFO - PROCESS | 14854 | console.error: PushService: 19:00:33 INFO - PROCESS | 14854 | stateChangeProcessEnqueue: Error transitioning state 19:00:33 INFO - PROCESS | 14854 | UnknownError 19:00:34 INFO - TEST-INFO | 14854: exit 0 19:00:34 INFO - Browser initialized. 19:00:34 INFO - Running cycle 1/1 for kraken test... 19:00:34 INFO - TEST-INFO | started process 14939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTq2oy_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:46 INFO - PROCESS | 14939 | RSS: Main: 173568000 19:00:46 INFO - PROCESS | 14939 | 19:00:49 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-beat-detection) 19:00:50 INFO - PROCESS | 14939 | RSS: Main: 236912640 19:00:50 INFO - PROCESS | 14939 | 19:00:52 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-dft) 19:00:53 INFO - PROCESS | 14939 | RSS: Main: 217821184 19:00:53 INFO - PROCESS | 14939 | 19:00:56 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-fft) 19:00:57 INFO - PROCESS | 14939 | RSS: Main: 299249664 19:00:57 INFO - PROCESS | 14939 | 19:00:59 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38717/tests/kraken/driver.html?testName=audio-oscillator) 19:00:59 INFO - PROCESS | 14939 | RSS: Main: 207945728 19:00:59 INFO - PROCESS | 14939 | 19:01:01 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:02 INFO - PROCESS | 14939 | RSS: Main: 213016576 19:01:02 INFO - PROCESS | 14939 | 19:01:05 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:06 INFO - PROCESS | 14939 | RSS: Main: 249884672 19:01:06 INFO - PROCESS | 14939 | 19:01:09 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38717/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:09 INFO - PROCESS | 14939 | RSS: Main: 248647680 19:01:09 INFO - PROCESS | 14939 | 19:01:12 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38717/tests/kraken/driver.html?testName=json-parse-financial) 19:01:13 INFO - PROCESS | 14939 | RSS: Main: 248516608 19:01:13 INFO - PROCESS | 14939 | 19:01:14 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:15 INFO - PROCESS | 14939 | RSS: Main: 210407424 19:01:15 INFO - PROCESS | 14939 | 19:01:17 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:17 INFO - PROCESS | 14939 | RSS: Main: 218587136 19:01:17 INFO - PROCESS | 14939 | 19:01:19 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:20 INFO - PROCESS | 14939 | RSS: Main: 227328000 19:01:20 INFO - PROCESS | 14939 | 19:01:23 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:23 INFO - PROCESS | 14939 | RSS: Main: 236019712 19:01:23 INFO - PROCESS | 14939 | 19:01:26 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:27 INFO - PROCESS | 14939 | RSS: Main: 233316352 19:01:27 INFO - PROCESS | 14939 | 19:01:28 INFO - PROCESS | 14939 | Cycle 1(1): loaded http://localhost:38717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38717/tests/kraken/driver.html?testName=ai-astar) 19:01:29 INFO - PROCESS | 14939 | RSS: Main: 284053504 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | __start_tp_report 19:01:29 INFO - PROCESS | 14939 | _x_x_mozilla_page_load 19:01:29 INFO - PROCESS | 14939 | _x_x_mozilla_page_load_details 19:01:29 INFO - PROCESS | 14939 | |i|pagename|runs| 19:01:29 INFO - PROCESS | 14939 | |0;ai-astar;108;111;111;110;112;110;112;111;111;109 19:01:29 INFO - PROCESS | 14939 | |1;audio-beat-detection;148;123;125;160;130;128;126;122;170;120 19:01:29 INFO - PROCESS | 14939 | |2;audio-dft;161;162;161;160;160;160;162;161;160;161 19:01:29 INFO - PROCESS | 14939 | |3;audio-fft;75;76;76;110;77;76;77;76;98;76 19:01:29 INFO - PROCESS | 14939 | |4;audio-oscillator;83;83;114;82;82;82;109;82;82;117 19:01:29 INFO - PROCESS | 14939 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 19:01:29 INFO - PROCESS | 14939 | |6;imaging-darkroom;146;146;146;146;146;146;147;148;147;146 19:01:29 INFO - PROCESS | 14939 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;97;96 19:01:29 INFO - PROCESS | 14939 | |8;json-parse-financial;53;52;52;52;52;54;54;52;52;54 19:01:29 INFO - PROCESS | 14939 | |9;json-stringify-tinderbox;61;61;61;61;61;60;60;60;61;61 19:01:29 INFO - PROCESS | 14939 | |10;stanford-crypto-aes;80;89;79;81;85;81;79;80;81;86 19:01:29 INFO - PROCESS | 14939 | |11;stanford-crypto-ccm;139;132;146;131;139;131;132;130;171;140 19:01:29 INFO - PROCESS | 14939 | |12;stanford-crypto-pbkdf2;164;166;163;166;166;169;166;163;167;163 19:01:29 INFO - PROCESS | 14939 | |13;stanford-crypto-sha256-iterative;67;68;66;69;66;65;65;65;69;64 19:01:29 INFO - PROCESS | 14939 | __end_tp_report 19:01:29 INFO - PROCESS | 14939 | __start_cc_report 19:01:29 INFO - PROCESS | 14939 | _x_x_mozilla_cycle_collect,1723 19:01:29 INFO - PROCESS | 14939 | __end_cc_report 19:01:29 INFO - PROCESS | 14939 | __startTimestamp1476410489203__endTimestamp 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | ------- Summary: start ------- 19:01:29 INFO - PROCESS | 14939 | Number of tests: 14 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.27 (1.1%) stddev-sans-first:0.97 19:01:29 INFO - PROCESS | 14939 | Values: 108.0 111.0 111.0 110.0 112.0 110.0 112.0 111.0 111.0 109.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.00 stddev:17.67 (13.7%) stddev-sans-first:18.13 19:01:29 INFO - PROCESS | 14939 | Values: 148.0 123.0 125.0 160.0 130.0 128.0 126.0 122.0 170.0 120.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:01:29 INFO - PROCESS | 14939 | Values: 161.0 162.0 161.0 160.0 160.0 160.0 162.0 161.0 160.0 161.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:12.10 (15.9%) stddev-sans-first:12.59 19:01:29 INFO - PROCESS | 14939 | Values: 75.0 76.0 76.0 110.0 77.0 76.0 77.0 76.0 98.0 76.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.12 (18.4%) stddev-sans-first:15.72 19:01:29 INFO - PROCESS | 14939 | Values: 83.0 83.0 114.0 82.0 82.0 82.0 109.0 82.0 82.0 117.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 19:01:29 INFO - PROCESS | 14939 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 19:01:29 INFO - PROCESS | 14939 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 148.0 147.0 146.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:01:29 INFO - PROCESS | 14939 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 97.0 96.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.50 stddev:0.95 (1.8%) stddev-sans-first:1.00 19:01:29 INFO - PROCESS | 14939 | Values: 53.0 52.0 52.0 52.0 52.0 54.0 54.0 52.0 52.0 54.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 19:01:29 INFO - PROCESS | 14939 | Values: 61.0 61.0 61.0 61.0 61.0 60.0 60.0 60.0 61.0 61.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:81.00 stddev:3.38 (4.2%) stddev-sans-first:3.50 19:01:29 INFO - PROCESS | 14939 | Values: 80.0 89.0 79.0 81.0 85.0 81.0 79.0 80.0 81.0 86.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:139.00 stddev:12.39 (8.9%) stddev-sans-first:13.14 19:01:29 INFO - PROCESS | 14939 | Values: 139.0 132.0 146.0 131.0 139.0 131.0 132.0 130.0 171.0 140.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.00 (1.2%) stddev-sans-first:2.07 19:01:29 INFO - PROCESS | 14939 | Values: 164.0 166.0 163.0 166.0 166.0 169.0 166.0 163.0 167.0 163.0 19:01:29 INFO - PROCESS | 14939 | 19:01:29 INFO - PROCESS | 14939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.78 (2.7%) stddev-sans-first:1.87 19:01:29 INFO - PROCESS | 14939 | Values: 67.0 68.0 66.0 69.0 66.0 65.0 65.0 65.0 69.0 64.0 19:01:29 INFO - PROCESS | 14939 | -------- Summary: end -------- 19:01:29 INFO - PROCESS | 14939 | 19:01:30 INFO - TEST-INFO | 14939: exit 0 19:01:30 INFO - TEST-OK | kraken | took 61534ms 19:01:30 INFO - SUITE-END | took 1178s 19:01:30 INFO - Completed test suite (00:19:39) 19:01:30 INFO - javascript benchmark 19:01:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2958.6005889204957, 2995.6854530274322, 2999.2651800308927, 3036.7874248802564, 3047.9390412191756, 5087.236914462823, 5156.974215128924, 5190.8442746717565, 5236.423993360732, 5283.049051170783, 5140.049090918183, 5159.613029022829, 5212.192110222912, 5231.476852314776, 5262.552683021938, 4726.574608285254, 4750.501197374278, 4797.328374027639, 4825.324454576362, 4848.53938875808, 4820.0, 4865.878353041185, 4926.679765815211, 4931.038447502739, 4987.551120399164, 4720.173969555349, 4776.904461910777, 4781.3545171401765, 4817.108834865544, 4878.70727756334, 4749.24012158053, 4835.6131509479155, 4835.758212089381, 4836.202026665596, 4843.22508398658, 4773.9761301193275, 4794.472608013116, 4799.400074990626, 4800.951990480085, 4803.447603525605, 5223.73881305937, 5260.92108618371, 5283.392409872876, 5291.894162116774, 5292.867678308035, 5607.4112218217315, 5611.466910643482, 5614.466625670555, 5635.915461268084, 5642.689652069134, 5679.062954612526, 5693.715314234271, 5693.77224911003, 5702.686352250625, 5748.5688573357165, 5308.389535203424, 5346.705931173784, 5350.5452036576935, 5351.892962140735, 5405.864853378618, 5575.804846830341, 5636.830895073154, 5651.067573850269, 5683.374828768832, 5835.94164058354, 5505.779768809202, 5512.255845460892, 5515.751791169407, 5564.554835613141, 5578.525825304813, 5563.972180139154, 5573.136163894603, 5576.525995290364, 5580.330360356783, 5583.022970980062, 5404.459554044564, 5441.075017247077, 5506.256655351476, 5566.304211973504, 5634.211210430543, 5535.750891209906, 5609.635373700697, 5610.326760788732, 5656.85857853557, 5661.716914154275, 4304.332828411539, 4309.461317335333, 4310.719803212781, 4315.913681726348, 4361.0, 3739.9439008414897, 3777.225668737902, 3830.367989281793, 3836.5971572984995, 3866.188100498927, 5184.455632158644, 5196.376434827845, 5204.1673332266655, 5205.375354957429, 5325.068113080196, 5662.348829884616, 5666.603337766399, 5683.772649094072, 5685.6304340218585, 5693.943060569424, 5205.06308864408, 5230.660007099526, 5242.7378631068295, 5247.160454327366, 5254.2118682197215, 4820.035992801454, 4855.247436647254, 4864.221724524059, 4864.78108485119, 4903.362562866804, 5667.376588575254, 5714.0571805652435, 5716.171155182558, 5726.455986681259, 5795.246617939641, 5663.461971112738, 5671.489565939085, 5671.801486947937, 5713.514351280188, 5737.110747834093, 5715.31416230055, 5819.5344372450945, 5826.213461182856, 5838.0950952600715, 5842.561807864512, 5271.736413179249, 5351.759170837244, 5524.530414914777, 5541.667499950016, 5544.750486228048, 5683.77264909399, 5758.884822303614, 5786.623869448473, 5794.449527294901, 5795.217645617788, 5476.808311709071, 5489.39616642161, 5490.450954904637, 5495.53287970511, 5500.917486237629, 5428.077226871363, 5487.972560137174, 5488.451154884479, 5489.204065410573, 5554.333479982428, 5271.446498117796, 5311.336082989626, 5416.0521908666615, 5440.863978400572, 5463.125899856004, 5537.418571049981, 5537.944620553743, 5543.334799823886, 5545.611807173459, 5549.916751248654, 5396.244525766474, 5421.349438067457, 5426.457354264542, 5427.077396842467, 5482.23248745168], "value": 5179.868797963117, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.2617662612374, 569.5529009727363, 607.5807692692042, 609.9695015249239, 622.0265284829239, 33699.0, 43007.78496107519, 44016.11967760643, 44066.55933440669, 47132.293015604795, 45200.773996129974, 45460.772696136555, 45654.54345456544, 45760.54239457604, 45788.3131753024, 7992.280694737473, 8196.795080122985, 8858.33562482813, 9019.413738107001, 9023.503707296097, 10410.115140213053, 10689.572417103307, 10713.08938740208, 11031.558737650485, 11046.723831904186, 10862.0, 10961.83557246642, 10965.0, 10965.342079475216, 10967.670969870916, 8122.862799208116, 8303.418760686754, 10443.164546836235, 10801.945990270038, 10892.0, 10293.485325733758, 10710.839337409867, 10724.302920310232, 10731.409772462512, 10735.248532602722, 42122.78938605318, 42438.78780606077, 42471.0, 42474.36288455676, 42515.14969700589, 3487.1630808606005, 3518.2611651553207, 3586.677199052072, 3596.478510615946, 3877.515310586177, 31179.53230701541, 31189.8440507796, 31426.842865785526, 32052.519212211835, 32828.835855820565, 4211.305134652778, 4266.978665106686, 4323.762193079379, 4384.539623339567, 4403.757793321366, 331857.0, 333208.0, 333706.0, 334450.0, 334924.32537837396, 57059.0, 57415.0, 57417.712911436014, 57476.0, 57548.71225643845, 36349.27301453956, 37363.813180933925, 37411.438828417595, 39617.20765584672, 39638.801805990784, 15882.523524294289, 15994.36022559108, 16063.678726425405, 16068.035917844967, 16069.437569685238, 11247.212695111428, 11261.0, 11786.528538858522, 11883.821742673867, 11994.220375675728, 18312.175952082187, 18868.15093320804, 18946.43160705181, 18978.335758248395, 19381.321653742052, 7075.5400898942435, 7086.468514861406, 7109.786706398713, 7177.641117944082, 7521.849563008709, 953.77109493721, 1003.4380746781826, 1038.948052597367, 1045.7281106912105, 1120.4957769003981, 31385.686143138275, 31609.367812643617, 31618.209544761565, 31934.395557369127, 32056.679433205834, 1060.5863713151878, 1086.766345235778, 1105.9170562207705, 1107.5846557540922, 1162.7325715085578, 15981.60045998836, 16590.91704541494, 16639.41762038323, 16655.167241637868, 17018.659626807643, 530111.0, 532745.0, 535239.0, 535399.0, 537355.0, 56596.0, 57112.71443642755, 57167.71416142976, 57174.42825571691, 57179.71410142923, 1182.479708928069, 1239.1202246404973, 1254.3978890132787, 1317.2754984758535, 1351.567498400522, 31107.68892311048, 32375.838120809247, 32771.0, 33110.33779324352, 33376.83311583426, 44255.77872110619, 45773.77113114413, 46266.30600540927, 46900.530994689616, 47438.525614744794, 381171.0, 383420.0, 384384.0, 384399.0, 385130.0, 26792.59811102796, 27948.720512795426, 28008.859955700093, 29559.26101847385, 29769.851150744107, 42216.78891605522, 43010.0, 43599.78200108979, 44311.0, 44431.555684444036, 36923.26153476969, 38417.4237386445, 39783.60216397799, 41545.376819347126, 43566.78216608897, 37303.81348093242, 39212.80393598014, 39366.606333936295, 39987.0, 40136.39795403013, 39513.60486395099, 40713.79643101884, 41026.384604231556, 41077.79461102795, 41142.38286425646, 31268.218294542818, 33023.50464743079, 33419.66580334165, 33455.49816752702, 33503.83248083744, 27245.318867028484, 27794.0, 27890.0, 28020.859895700392, 28030.0], "value": 19769.369793052112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.4150213413874, 381.1861675323184, 387.56979752474757, 400.4553806822721, 418.9895252618686, 13233.735325293488, 18160.27358905644, 18306.26774929003, 20168.899155504238, 20296.492587685316, 18344.724829127576, 18378.264869405208, 19125.0, 19237.134328955195, 19282.61434771304, 5425.782968681257, 5719.714014299289, 5722.198892155102, 5724.771009159628, 5724.998125328072, 5567.610267281292, 5588.189712491686, 5686.630369026021, 5821.0, 5851.210086638313, 5920.851978700523, 5926.081457374093, 5932.911006334908, 5934.703264836762, 5936.703164841762, 5606.131049687285, 5849.473547380735, 5893.528517718572, 5929.110633404981, 5984.4613984741145, 5641.0, 5767.394423585547, 5816.912746308766, 5821.27234095738, 5829.621074630178, 22234.444138896495, 22348.553028939492, 22556.533825301467, 22661.0, 22889.77110228893, 2262.8302877284104, 2295.36877358726, 2321.8374713770045, 2393.8324317297797, 2425.7331693513697, 9945.403275803403, 10115.645952391631, 10146.615545346838, 10350.171986241157, 10600.893991060067, 1876.5402476393235, 1898.2122419196016, 1987.4633848860872, 1990.4128282156653, 2005.2981456490259, 54582.0, 72485.0, 72876.63561682211, 84482.15517844804, 84766.57616711876, 10438.895611043792, 10766.138708903269, 10867.565297388173, 10977.506012229469, 11009.61466348674, 15243.390264389522, 15314.770278445832, 15322.923385383001, 15329.310181041657, 15333.0, 7479.887801682979, 7612.238776122344, 7713.4214933880185, 7717.2282771722375, 7823.647935842901, 7100.289971002859, 7161.641917904084, 7372.410207183412, 7390.29792169743, 7433.10802703679, 4583.0, 4671.252599584051, 4687.7656117194, 4836.903261934742, 4867.634927380461, 1936.3610008697096, 1965.0, 2001.909914053871, 2011.6278488479677, 2016.3446879764135, 804.7827086686561, 812.7480481050893, 821.7411515372758, 947.1617618407621, 1010.8938561450942, 18447.26210951547, 19029.714554281698, 19066.142023608973, 19104.713429298572, 19373.612527749367, 987.1214618989105, 997.0976266478848, 1002.9348092373972, 1003.7139415266614, 1036.8703912011, 9980.305317564216, 10503.94748026255, 10512.0, 10575.20685948557, 10596.364218146937, 412531.0, 416582.0, 419857.30499432376, 420026.0, 437769.0, 91420.5428972851, 94243.52878235564, 95251.0, 96109.38483519384, 100973.49513252387, 1021.5964693945998, 1024.8872624011353, 1067.3329169269207, 1068.9144868410508, 1069.7806949575318, 16635.83364166343, 16676.332946681996, 17286.394976175772, 17557.0, 17781.555461113574, 29566.0, 36702.63297367099, 36799.0, 41372.37941430941, 41641.167176656905, 50322.74838625784, 50620.49379506305, 53391.73304133455, 59096.40903590909, 62051.52046871343, 8030.036395632328, 8195.631196596287, 8255.298299644597, 8512.787180320542, 8579.82840343202, 8873.778155546162, 11813.645590632295, 12822.358882056047, 12989.545365912149, 13074.607761767162, 11231.775364492827, 11338.14963877729, 11565.537378504765, 11567.248128871597, 11864.76270474603, 11406.372649504357, 11456.942715286703, 11534.250273732516, 11537.942310288396, 11745.882541174478, 11462.426878655868, 11508.94245528767, 11531.365774882463, 11754.412279386168, 11882.28706277626, 7316.926830731624, 7439.2188820173105, 7494.6252687366505, 7786.844263114819, 8721.389502734748, 9705.951470242886, 11259.380734059705, 11375.0, 11483.770324593628, 11849.881501185222], "value": 8973.744739078224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.6997095624442, 1450.6735984403508, 1482.770170623553, 1699.3405320673146, 1699.413702272717, 8419.873701894476, 9095.54522273887, 9099.727008189757, 9108.271338292938, 9110.544472776368, 7632.389408847279, 7795.493292935969, 7843.058832940041, 8079.474834135792, 8919.554022298875, 2050.28240115959, 2130.8401869859745, 2181.432827464863, 2185.2242453928866, 2208.6907832903407, 2210.993049452743, 2217.2350539063996, 2234.1175235781857, 2237.071615279657, 2240.4510894830787, 2193.56128774245, 2297.7127859017623, 2308.6421604651305, 2312.8034117099983, 2316.339843144704, 2282.8402011859175, 2285.2915596165158, 2298.816094712419, 2304.4584522637165, 2308.5729140109133, 2257.81937445004, 2262.3439202631216, 2274.6701728249313, 2277.749447560767, 2292.323764489463, 8218.547979861105, 8781.253593444564, 8909.109089091104, 8930.151635594608, 8937.374383793138, 5097.1844504879045, 5147.279380886679, 5193.818216362447, 5203.947960520384, 5242.79028838846, 3259.837008149583, 3363.9663603363897, 3415.7267418606452, 3478.7912725236315, 3485.4597537381746, 1108.4845546820686, 1140.988590114105, 1148.7817314710262, 1166.3002198680808, 1176.4882276209876, 12327.075469339836, 12391.070669699719, 12402.503899843996, 12437.689057773538, 12453.190542614791, 4279.87160385189, 4581.266997280419, 4593.839215627437, 4630.560096790799, 4636.211843986463, 10410.427426491464, 10419.322744021765, 10419.374837509622, 10428.687139385831, 10433.217508686726, 5267.9736601316745, 5285.339332583427, 5288.418273989858, 5293.258943747878, 5293.470652934753, 4710.811567537328, 4827.806887724451, 4883.34074899891, 4883.951160488421, 4885.902281954341, 3519.1202199450136, 3616.9819150904605, 3775.3959366501226, 3821.9808900955873, 3882.5340959084524, 1205.722683782735, 1209.2563073709605, 1211.896988755948, 1216.7505661339403, 1228.2078059651474, 919.1084647891535, 921.3504479342048, 937.8323986636544, 946.2855544064325, 959.8032403357295, 5618.353889302701, 5698.686572238566, 5733.971330143406, 5973.581849270509, 5983.222181116514, 893.8569828827357, 905.4295793649958, 961.293449314753, 963.9855402168973, 971.455984648599, 3728.6271372862498, 3774.8867533974026, 3905.977540629155, 4015.6988225883174, 4024.0744628735556, 10808.0, 11043.282186657842, 11141.721456963478, 11165.72085697864, 11216.102711783038, 10906.781864362669, 10930.125589952784, 10931.726706832234, 11037.337759734442, 11112.277701949348, 8298.460600060977, 8343.249107580468, 8360.874586881202, 8369.200621866328, 8376.832463350698, 5590.664560126405, 5628.268325117709, 5668.2064510967675, 5786.566007549535, 5862.67755273447, 10215.0, 10234.488275586042, 10257.640982565574, 10296.433696146783, 10373.481325933522, 10162.288639795439, 10182.0, 10345.896541034794, 10469.476526173814, 10480.213983951082, 7873.133955264801, 7997.480163789335, 7998.880016799869, 8006.279434850891, 8006.919930800617, 7108.822279442848, 7557.584332861526, 8135.71524996646, 8574.31405487547, 8645.8703119452, 7685.11621163551, 7732.536047837148, 7798.142204357629, 7818.374530037697, 7823.295903368724, 7361.079865016873, 7406.481546291708, 7445.739399121005, 7481.88777168332, 7538.736144234926, 6861.416779573592, 6874.931250687429, 6930.306969303029, 6953.0, 7023.859522809617, 4911.582515486224, 4915.950840491692, 4938.358013458227, 4974.0797952378925, 5059.114654935445, 4636.907261854812, 4639.791209395653, 4694.92957605643, 4772.880677983078, 4791.712497250176], "value": 4567.854615248084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5102346480278, 333.44314993960086, 338.91696534349074, 341.97264218862483, 343.4539082858255, 5055.797768089281, 5205.947940520594, 5206.895862082756, 5298.08605267103, 5339.706316152615, 5077.568406685427, 5180.740962951847, 5203.765830537625, 5205.193195054763, 5221.503957124077, 4157.52188498322, 4168.187203495319, 4170.937435938464, 4178.203372549802, 4214.557471465498, 3945.842166313344, 4074.348104303312, 4194.412782210493, 4197.677731514578, 4198.20234155511, 4089.0, 4089.325261331877, 4091.8158682859194, 4101.507819061717, 4103.281925662997, 4087.751736544918, 4096.32410652242, 4098.385242213677, 4100.507939047304, 4136.896577585554, 3650.963490365089, 3658.579263384718, 3660.3228402745312, 3662.1393972416463, 3663.102539877747, 5024.171011783052, 5078.873028174288, 5120.615953803443, 5120.820771272987, 5149.3305870237, 4696.497120921306, 4724.055188962221, 4730.574248317668, 4735.644826638016, 4739.14695354836, 5420.512153906128, 5421.810236641738, 5451.536619387317, 5467.289252397163, 5475.890482190334, 3810.428435734634, 3946.4474973503734, 3970.7617542947514, 3995.0212198011673, 4002.5597184309704, 5662.518685911661, 5692.146178073281, 5703.828885133453, 5704.885902281972, 5706.172604972256, 4063.6952228582973, 4079.5920407958965, 4104.932717493473, 4114.814833332507, 4120.21715873983, 3907.648311651908, 4082.6121518455698, 4105.3020986432375, 4128.6284234419045, 4160.604742549453, 4689.835855745033, 4691.9912218873105, 4694.389729335233, 4705.929411058837, 4732.526747325309, 5520.834374968757, 5533.972330138404, 5543.0, 5578.721063946787, 5584.431161665598, 1318.7164759576544, 1320.3662242123835, 1402.3268830961197, 1415.971680566383, 1422.8901456863664, 874.6763697431991, 904.3307952115388, 905.4612505559313, 913.1234015345343, 916.1434059154578, 4582.587567118975, 4585.945232596521, 4609.262517997105, 4632.25883858581, 4633.258678611406, 4913.459519452857, 4917.434495033117, 4922.58158056562, 4928.654994150446, 4957.983613359253, 4439.756868076944, 4600.861974140781, 4618.584327410549, 4619.491855895849, 4635.513271106553, 2593.597992311195, 2597.9867851537538, 2614.9869250653624, 2619.3189770659383, 2625.9474810503684, 4998.151423403959, 5033.597312215014, 5040.243963405445, 5046.798128074909, 5048.444671086178, 4973.303737476756, 4984.77568509418, 4989.55094041538, 5007.39911210657, 5369.4630536946, 5853.64878107315, 5885.6468611882565, 5902.291724993029, 5910.970445147918, 5926.881462370815, 5703.600747947604, 5718.256626638677, 5731.340895797037, 5733.770649173986, 5735.254416925773, 5456.911639317212, 5592.524635406036, 5624.718764061862, 5643.899439609237, 5693.28833895763, 5895.700676736162, 5896.233489646319, 5897.882042359043, 5914.0, 5916.26046744157, 4099.36459848712, 4121.093359460914, 4123.463949686641, 4134.297169481256, 4137.586241375839, 5368.32895888014, 5553.972230138985, 5665.943340566707, 5717.942820571741, 5723.427657234243, 5385.9192112119135, 5419.729013549386, 5559.972200138974, 5601.551875849841, 5638.464345887134, 5592.692401917933, 5612.466815652507, 5625.184348269559, 5648.943510564842, 5653.349864765604, 5236.371635403776, 5531.225628412106, 5534.059209934401, 5552.194931734795, 5612.354579223442, 5573.742634233142, 5577.247071645438, 5577.972110139423, 5580.665160090408, 5585.720713964367, 5478.164814787091, 5493.725313734377, 5501.752421140978, 5529.972350138223, 5547.639403438763], "value": 4126.498372558516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.6991543213579, 793.9920600793994, 819.9180081991801, 827.4952279109739, 835.4235577451558, 15434.922825385871, 16888.07115608641, 16911.577210569743, 16916.577085572837, 16930.915345423273, 15319.387224511007, 15361.231938403063, 15389.846101538982, 15411.306491207895, 15450.0, 777.428589986361, 802.7993001749562, 803.2650125135494, 803.8311954489565, 804.1476035402492, 642.4828013449171, 652.5530011941811, 770.414484991405, 804.8028233082903, 809.7449303469389, 831.3390854270839, 837.4054421360842, 837.6858677995751, 840.3025488844276, 842.9662813487453, 833.2292629317917, 835.0105125426389, 835.0939230934443, 835.3192148399065, 835.6949713354643, 501.4809671989473, 503.49398854151343, 599.2000679093416, 617.8300967234002, 619.981400557984, 14101.435942562286, 14993.250337483192, 15088.547343579601, 15101.546953591409, 15113.622159445991, 13167.275799831006, 13955.651108722263, 14042.438302467888, 14114.064644951954, 14117.505887293895, 12269.386530673431, 12401.13192076555, 12452.252864828139, 12454.501819927193, 12685.238885666797, 4381.738135681368, 4412.227860124497, 4482.932756008662, 4509.774511274456, 4544.136614043321, 74861.62569187119, 76205.0, 76398.0, 77009.22990770076, 79721.60139199383, 11293.15301352402, 11410.600628978113, 11447.484863181176, 11509.366984815748, 11526.88473115275, 21610.0, 21623.891880540497, 21637.672465506963, 21663.783362166178, 21848.0, 7953.32396746283, 7999.640016199285, 8021.358291336679, 8024.959875200703, 8107.473014254055, 4386.078923426053, 4413.558644135625, 4423.601875831127, 4465.1962646723905, 4536.750478723702, 3507.982460087734, 3540.5220295260324, 3575.8927232183078, 3604.33319835826, 3617.529721136288, 604.4952464691944, 618.523736722721, 619.3280290884351, 622.0575827621158, 633.0757094641782, 590.5069267161882, 667.609448472649, 691.5677701436603, 697.1529591546296, 705.8517711280689, 8539.274161696201, 8543.102974187745, 8849.557522123869, 8908.8663670045, 8972.0, 646.9838254043686, 650.1742786660914, 686.3891136888174, 696.979090627282, 697.3758486154965, 4307.267764480046, 4373.2565463871215, 4427.911441771211, 4436.251367594377, 4470.776461176928, 70250.64874675593, 71261.0, 123483.0, 125724.0, 128005.35997319953, 99030.5048474753, 102369.48815255876, 104033.0, 105656.0, 106251.4687426558, 82770.0, 85477.57261213654, 86187.64091565818, 86950.56524717336, 88744.11255887487, 8350.331973442231, 8385.161483851565, 8413.495190288602, 8441.91558084436, 8544.74365769028, 51206.0, 52265.47734522606, 53358.0, 53880.46119538754, 55800.72099639638, 78520.0, 78936.60531697304, 79263.0, 81962.59018704869, 82071.5896420514, 11053.668389948314, 11155.358728048794, 11217.102631789274, 11290.15323850698, 11511.0, 12377.814332785196, 12425.19236249641, 12519.31143787064, 12912.483500659868, 14891.255437228312, 13318.533851315158, 13360.465581376637, 13382.531611393555, 14355.784663229852, 15093.849061509245, 11100.777984440105, 12919.870801292243, 13398.531051413154, 13643.795343069663, 13841.169529828243, 13210.0, 13959.371828267549, 14154.400780767424, 14283.714325713636, 14284.287283987946, 11045.023791434916, 11091.389973551532, 11154.442277885912, 11488.2687768987, 11667.183297169116, 11072.280301780358, 11160.609378671708, 11245.71885702864, 11273.154513411362, 11582.6525204244], "value": 7434.076183498926, "unit": "score"}], "name": "dromaeo_css", "value": 7106.276214657466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 110.0, 112.0, 110.0, 112.0, 111.0, 111.0, 109.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 125.0, 160.0, 130.0, 128.0, 126.0, 122.0, 170.0, 120.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 110.0, 77.0, 76.0, 77.0, 76.0, 98.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 82.0, 82.0, 82.0, 109.0, 82.0, 82.0, 117.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 148.0, 147.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 52.0, 54.0, 54.0, 52.0, 52.0, 54.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 89.0, 79.0, 81.0, 85.0, 81.0, 79.0, 80.0, 81.0, 86.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 146.0, 131.0, 139.0, 131.0, 132.0, 130.0, 171.0, 140.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 163.0, 166.0, 166.0, 169.0, 166.0, 163.0, 167.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 69.0, 66.0, 65.0, 65.0, 65.0, 69.0, 64.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1505.2999999999997, "alertThreshold": 2.0}]} 19:01:30 INFO - Return code: 0 19:01:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:01:31 INFO - # TBPL SUCCESS # 19:01:31 INFO - Running post-action listener: _resource_record_post_action 19:01:31 INFO - [mozharness: 2016-10-14 02:01:31.024999Z] Finished run-tests step (success) 19:01:31 INFO - Running post-run listener: _resource_record_post_run 19:01:31 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405155840; Read time: 12; Write time: 244324 19:01:31 INFO - TinderboxPrint: CPU usage
13.1% 19:01:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:01:31 INFO - TinderboxPrint: I/O write bytes / time
405,155,840 / 244,324 19:01:31 INFO - TinderboxPrint: CPU idle
8,294.0 (86.9%) 19:01:31 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 19:01:31 INFO - TinderboxPrint: Swap in / out
0 / 0 19:01:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114331648; Read time: 0; Write time: 60544 19:01:31 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289935360; Read time: 0; Write time: 183760 19:01:31 INFO - Running post-run listener: _upload_blobber_files 19:01:31 INFO - Blob upload gear active. 19:01:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:01:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:01:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:01:32 INFO - (blobuploader) - INFO - Open directory for files ... 19:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:32 INFO - (blobuploader) - INFO - Done attempting. 19:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:33 INFO - (blobuploader) - INFO - Done attempting. 19:01:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:01:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:01:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:01:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:01:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:01:37 INFO - (blobuploader) - INFO - Done attempting. 19:01:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:01:37 INFO - Return code: 0 19:01:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:01:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:01:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57757df550023c43500225c0f0bf56d84380d3c70d03736abff5fcc97a1912e96bccb74f8555e648e38520aa41dc20243537c0d459cdae5500c816ea305ce8e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f744874c080c0afb2f30575039018eacb925d81b186c44965bdb1c17d2c6e18d76d6324d7a9e06387e038f8ac2d584ce9eff1ebdd681f6b2532126aca4732a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06d739a5edf5a9d80cfd739e905c198887ca389690677d278f61a05855ea2ea006e7a11e157cc0543a252223da7f5425e56a465e1de77cfa880ce8be598dc8b1"} 19:01:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:01:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:01:37 INFO - Contents: 19:01:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57757df550023c43500225c0f0bf56d84380d3c70d03736abff5fcc97a1912e96bccb74f8555e648e38520aa41dc20243537c0d459cdae5500c816ea305ce8e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f744874c080c0afb2f30575039018eacb925d81b186c44965bdb1c17d2c6e18d76d6324d7a9e06387e038f8ac2d584ce9eff1ebdd681f6b2532126aca4732a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06d739a5edf5a9d80cfd739e905c198887ca389690677d278f61a05855ea2ea006e7a11e157cc0543a252223da7f5425e56a465e1de77cfa880ce8be598dc8b1"} 19:01:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:01:37 INFO - Copying logs to upload dir... 19:01:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:01:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.846754 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-13 19:01:36.899714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 19:01:36.903174) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57757df550023c43500225c0f0bf56d84380d3c70d03736abff5fcc97a1912e96bccb74f8555e648e38520aa41dc20243537c0d459cdae5500c816ea305ce8e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f744874c080c0afb2f30575039018eacb925d81b186c44965bdb1c17d2c6e18d76d6324d7a9e06387e038f8ac2d584ce9eff1ebdd681f6b2532126aca4732a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06d739a5edf5a9d80cfd739e905c198887ca389690677d278f61a05855ea2ea006e7a11e157cc0543a252223da7f5425e56a465e1de77cfa880ce8be598dc8b1"} build_url:https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011379 build_url: 'https://queue.taskcluster.net/v1/task/M0lsFgIkShyTCokXKngsWA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57757df550023c43500225c0f0bf56d84380d3c70d03736abff5fcc97a1912e96bccb74f8555e648e38520aa41dc20243537c0d459cdae5500c816ea305ce8e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f744874c080c0afb2f30575039018eacb925d81b186c44965bdb1c17d2c6e18d76d6324d7a9e06387e038f8ac2d584ce9eff1ebdd681f6b2532126aca4732a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06d739a5edf5a9d80cfd739e905c198887ca389690677d278f61a05855ea2ea006e7a11e157cc0543a252223da7f5425e56a465e1de77cfa880ce8be598dc8b1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 19:01:36.929965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 19:01:36.930428) ========= 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=6d15e502d8e29d5d2676d664000001c3-1476409255.749551-1670150905 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 19:01:37.018280) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 19:01:37.019006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 19:01:37.019597) ========= ========= Total master_lag: 0.19 =========