builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-054 starttime: 1476749864.53 results: success (0) buildid: 20161017154020 builduid: f0787916026a4ef7ba8fb8773c4642dc revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.526107) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.526574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.526864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.543180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.543605) ========= 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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 17:17:45-- 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% 69.8M=0s 2016-10-17 17:17:45 (69.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108324 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.665187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.665495) ========= 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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021050 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.714416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:44.714774) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47be3ae8a710b35f040dffe7403877e764ab61ac --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 47be3ae8a710b35f040dffe7403877e764ab61ac --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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 17:17:45,311 truncating revision to first 12 chars 2016-10-17 17:17:45,312 Setting DEBUG logging. 2016-10-17 17:17:45,312 attempt 1/10 2016-10-17 17:17:45,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47be3ae8a710?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 17:17:45,675 unpacking tar archive at: fx-team-47be3ae8a710/testing/mozharness/ program finished with exit code 0 elapsedTime=0.683779 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:45.411909) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:45.412245) ========= script_repo_revision: 47be3ae8a710b35f040dffe7403877e764ab61ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:45.412660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:45.412923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 17:17:45.422513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-17 17:17:45.422939) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:17:46 INFO - MultiFileLogger online at 20161017 17:17:46 in /builds/slave/test 17:17:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:17:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:17:46 INFO - {'append_to_log': False, 17:17:46 INFO - 'base_work_dir': '/builds/slave/test', 17:17:46 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:17:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:17:46 INFO - 'branch': 'Fx-Team-Non-PGO', 17:17:46 INFO - 'buildbot_json_path': 'buildprops.json', 17:17:46 INFO - 'config_files': ('talos/linux_config.py',), 17:17:46 INFO - 'default_actions': ('clobber', 17:17:46 INFO - 'read-buildbot-config', 17:17:46 INFO - 'download-and-extract', 17:17:46 INFO - 'populate-webroot', 17:17:46 INFO - 'create-virtualenv', 17:17:46 INFO - 'install', 17:17:46 INFO - 'run-tests'), 17:17:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:17:46 INFO - 'download_minidump_stackwalk': True, 17:17:46 INFO - 'download_symbols': 'ondemand', 17:17:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:17:46 INFO - 'tooltool.py': '/tools/tooltool.py', 17:17:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:17:46 INFO - '/tools/misc-python/virtualenv.py')}, 17:17:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:17:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:17:46 INFO - 'installer_path': 'installer.exe', 17:17:46 INFO - 'log_level': 'info', 17:17:46 INFO - 'log_name': 'talos', 17:17:46 INFO - 'log_to_console': True, 17:17:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:17:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:17:46 INFO - 'opt_config_files': (), 17:17:46 INFO - 'pip_index': False, 17:17:46 INFO - 'sps_profile': False, 17:17:46 INFO - 'sps_profile_interval': 0, 17:17:46 INFO - 'suite': 'dromaeojs', 17:17:46 INFO - 'system_bits': '32', 17:17:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:17:46 INFO - 'title': 'talos-linux64-ix-054', 17:17:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:17:46 INFO - 'use_talos_json': True, 17:17:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:17:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:17:46 INFO - 'work_dir': 'build'} 17:17:46 INFO - [mozharness: 2016-10-18 00:17:46.120860Z] Running clobber step. 17:17:46 INFO - Running pre-action listener: _resource_record_pre_action 17:17:46 INFO - Running main action method: clobber 17:17:46 INFO - rmtree: /builds/slave/test/build 17:17:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:17:46 INFO - Running post-action listener: _resource_record_post_action 17:17:46 INFO - [mozharness: 2016-10-18 00:17:46.578242Z] Finished clobber step (success) 17:17:46 INFO - [mozharness: 2016-10-18 00:17:46.578347Z] Running read-buildbot-config step. 17:17:46 INFO - Running pre-action listener: _resource_record_pre_action 17:17:46 INFO - Running main action method: read_buildbot_config 17:17:46 INFO - Using buildbot properties: 17:17:46 INFO - { 17:17:46 INFO - "project": "", 17:17:46 INFO - "product": "firefox", 17:17:46 INFO - "script_repo_revision": "production", 17:17:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:17:46 INFO - "repository": "", 17:17:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:17:46 INFO - "buildid": "20161017154020", 17:17:46 INFO - "pgo_build": "False", 17:17:46 INFO - "basedir": "/builds/slave/test", 17:17:46 INFO - "buildnumber": 3395, 17:17:46 INFO - "slavename": "talos-linux64-ix-054", 17:17:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:17:46 INFO - "platform": "ubuntu64_hw", 17:17:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:17:46 INFO - "branch": "fx-team", 17:17:46 INFO - "repo_path": "integration/fx-team", 17:17:46 INFO - "revision": "47be3ae8a710b35f040dffe7403877e764ab61ac", 17:17:46 INFO - "stage_platform": "linux64", 17:17:46 INFO - "builduid": "f0787916026a4ef7ba8fb8773c4642dc", 17:17:46 INFO - "slavebuilddir": "test" 17:17:46 INFO - } 17:17:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:17:46 INFO - Running post-action listener: _resource_record_post_action 17:17:46 INFO - [mozharness: 2016-10-18 00:17:46.580754Z] Finished read-buildbot-config step (success) 17:17:46 INFO - [mozharness: 2016-10-18 00:17:46.580840Z] Running download-and-extract step. 17:17:46 INFO - Running pre-action listener: _resource_record_pre_action 17:17:46 INFO - Running main action method: download_and_extract 17:17:46 INFO - mkdir: /builds/slave/test/build/tests 17:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:17:46 INFO - trying https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/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 17:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/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 17:17:47 INFO - Downloaded 1361 bytes. 17:17:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:17:47 INFO - Using the following test package requirements: 17:17:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:17:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:17:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'jsshell-linux-x86_64.zip'], 17:17:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:17:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:17:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:17:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:17:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:17:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:17:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:17:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:17:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:47 INFO - Fetch https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:17:48 INFO - Http code: 200 17:17:48 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 17:17:48 INFO - x-amz-cf-id: oP3FVA0sbDppcbPK_cK2encX5ujALpX542c7jgkbPWlpC86_o95NCA== 17:17:48 INFO - x-amz-version-id: bhQpfBhSO_GYbmgTLLcZsH2wODqv_i8m 17:17:48 INFO - Expected file size: 20520503 17:17:48 INFO - Obtained file size: 20520503 17:17:52 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 17:17:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:17:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:17:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:17:53 INFO - Http code: 200 17:17:53 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 17:17:53 INFO - x-amz-cf-id: x8xux-faLWeD_N9TjHL4xXPNm9znrwWiHBhvKvIEoKQJFtFXA7Ewkg== 17:17:53 INFO - x-amz-version-id: bhQpfBhSO_GYbmgTLLcZsH2wODqv_i8m 17:17:53 INFO - Expected file size: 20520503 17:17:53 INFO - Obtained file size: 20520503 17:17:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:17:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:17:58 INFO - Fetch https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:17:59 INFO - Http code: 200 17:17:59 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 17:17:59 INFO - x-amz-cf-id: rnLct8Q7GZht6ukP7OaF25Dake_RGkCuj_2TkHKOzEQL_2lc7Y1dTg== 17:17:59 INFO - x-amz-version-id: iWBkRJeYH9EbU30LKOUBn_AQcT1SnQ46 17:17:59 INFO - Expected file size: 14409028 17:17:59 INFO - Obtained file size: 14409028 17:18:00 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')]} 17:18:00 INFO - trying https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:18:00 INFO - Downloading https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/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 17:18:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/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 17:18:02 INFO - Downloaded 55567514 bytes. 17:18:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:18:02 INFO - mkdir: /builds/slave/test/properties 17:18:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:18:02 INFO - Writing to file /builds/slave/test/properties/build_url 17:18:02 INFO - Contents: 17:18:02 INFO - build_url:https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:18:03 INFO - Running post-action listener: _resource_record_post_action 17:18:03 INFO - Running post-action listener: set_extra_try_arguments 17:18:03 INFO - [mozharness: 2016-10-18 00:18:03.044627Z] Finished download-and-extract step (success) 17:18:03 INFO - [mozharness: 2016-10-18 00:18:03.044924Z] Running populate-webroot step. 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: populate_webroot 17:18:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:18:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:18:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:18:03 INFO - '--tppagecycles', 17:18:03 INFO - '7'], 17:18:03 INFO - 'tests': ['tsvgm']}}, 17:18:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:18:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:18:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:18:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:18:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:18:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['damp', 'tps']}, 17:18:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'tests': ['damp', 'tps']}, 17:18:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['dromaeo_dom']}, 17:18:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:18:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['basic_compositor_video']}, 17:18:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:18:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'other-e10s': {'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['a11yr', 17:18:03 INFO - 'ts_paint', 17:18:03 INFO - 'tpaint', 17:18:03 INFO - 'sessionrestore', 17:18:03 INFO - 'sessionrestore_no_auto_restore', 17:18:03 INFO - 'tabpaint']}, 17:18:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['tsvgx', 17:18:03 INFO - 'tsvgr_opacity', 17:18:03 INFO - 'tart', 17:18:03 INFO - 'tscrollx', 17:18:03 INFO - 'cart']}, 17:18:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:18:03 INFO - 'tsvgr_opacity', 17:18:03 INFO - 'tart', 17:18:03 INFO - 'tscrollx', 17:18:03 INFO - 'cart']}, 17:18:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'talos_options': ['--disable-e10s'], 17:18:03 INFO - 'tests': ['tp5o']}, 17:18:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'tests': ['tp5o']}, 17:18:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'talos_options': ['--disable-e10s', 17:18:03 INFO - '--xperf_path', 17:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:03 INFO - 'tests': ['tp5n']}, 17:18:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:18:03 INFO - 'talos_options': ['--xperf_path', 17:18:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:18:03 INFO - 'tests': ['tp5n']}}, 17:18:03 INFO - 'talos.zip': {'path': '', 17:18:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:18:03 INFO - Running post-action listener: _resource_record_post_action 17:18:03 INFO - [mozharness: 2016-10-18 00:18:03.062386Z] Finished populate-webroot step (success) 17:18:03 INFO - [mozharness: 2016-10-18 00:18:03.062474Z] Running create-virtualenv step. 17:18:03 INFO - Running pre-action listener: _resource_record_pre_action 17:18:03 INFO - Running main action method: create_virtualenv 17:18:03 INFO - Creating virtualenv /builds/slave/test/build/venv 17:18:03 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 17:18:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:18:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:18:03 INFO - Using real prefix '/usr' 17:18:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:18:03 INFO - Installing distribute.............................................................................................................................................................................................done. 17:18:05 INFO - Installing pip.................done. 17:18:05 INFO - Return code: 0 17:18:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:18:05 INFO - Reading from file tmpfile_stdout 17:18:05 INFO - Output received: 17:18:05 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) 17:18:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:18:05 INFO - Using env: {'DISPLAY': ':0', 17:18:05 INFO - 'HOME': '/home/cltbld', 17:18:05 INFO - 'LANG': 'en_US.UTF-8', 17:18:05 INFO - 'LANGUAGE': 'en_US:en', 17:18:05 INFO - 'LOGNAME': 'cltbld', 17:18:05 INFO - 'MAIL': '/var/mail/cltbld', 17:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:05 INFO - 'MOZ_NO_REMOTE': '1', 17:18:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:05 INFO - 'NO_EM_RESTART': '1', 17:18:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:05 INFO - 'PWD': '/builds/slave/test', 17:18:05 INFO - 'SHELL': '/bin/bash', 17:18:05 INFO - 'SHLVL': '1', 17:18:05 INFO - 'TERM': 'linux', 17:18:05 INFO - 'TMOUT': '86400', 17:18:05 INFO - 'USER': 'cltbld', 17:18:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:05 INFO - '_': '/tools/buildbot/bin/python'} 17:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:06 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 17:18:06 INFO - Cleaning up... 17:18:06 INFO - Return code: 0 17:18:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:06 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:06 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 17:18:06 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 17:18:06 INFO - Using env: {'DISPLAY': ':0', 17:18:06 INFO - 'HOME': '/home/cltbld', 17:18:06 INFO - 'LANG': 'en_US.UTF-8', 17:18:06 INFO - 'LANGUAGE': 'en_US:en', 17:18:06 INFO - 'LOGNAME': 'cltbld', 17:18:06 INFO - 'MAIL': '/var/mail/cltbld', 17:18:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:06 INFO - 'MOZ_NO_REMOTE': '1', 17:18:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:06 INFO - 'NO_EM_RESTART': '1', 17:18:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:06 INFO - 'PWD': '/builds/slave/test', 17:18:06 INFO - 'SHELL': '/bin/bash', 17:18:06 INFO - 'SHLVL': '1', 17:18:06 INFO - 'TERM': 'linux', 17:18:06 INFO - 'TMOUT': '86400', 17:18:06 INFO - 'USER': 'cltbld', 17:18:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:06 INFO - '_': '/tools/buildbot/bin/python'} 17:18:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:06 INFO - Downloading/unpacking psutil>=3.1.1 17:18:06 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 17:18:06 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 17:18:06 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 17:18:06 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 17:18:06 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 17:18:06 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 17:18:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:18:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:08 INFO - Installing collected packages: psutil 17:18:08 INFO - Running setup.py install for psutil 17:18:08 INFO - building 'psutil._psutil_linux' extension 17:18:08 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 17:18:08 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 17:18:08 INFO - building 'psutil._psutil_posix' extension 17:18:08 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 17:18:08 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 17:18:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:18:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:18:08 INFO - Successfully installed psutil 17:18:08 INFO - Cleaning up... 17:18:08 INFO - Return code: 0 17:18:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:18:08 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')]} 17:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:08 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')]} 17:18:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:08 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:08 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 17:18:08 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 17:18:08 INFO - Using env: {'DISPLAY': ':0', 17:18:08 INFO - 'HOME': '/home/cltbld', 17:18:08 INFO - 'LANG': 'en_US.UTF-8', 17:18:08 INFO - 'LANGUAGE': 'en_US:en', 17:18:08 INFO - 'LOGNAME': 'cltbld', 17:18:08 INFO - 'MAIL': '/var/mail/cltbld', 17:18:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:08 INFO - 'MOZ_NO_REMOTE': '1', 17:18:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:08 INFO - 'NO_EM_RESTART': '1', 17:18:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:08 INFO - 'PWD': '/builds/slave/test', 17:18:08 INFO - 'SHELL': '/bin/bash', 17:18:08 INFO - 'SHLVL': '1', 17:18:08 INFO - 'TERM': 'linux', 17:18:08 INFO - 'TMOUT': '86400', 17:18:08 INFO - 'USER': 'cltbld', 17:18:08 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:08 INFO - '_': '/tools/buildbot/bin/python'} 17:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:18:11 INFO - Installing collected packages: mozsystemmonitor 17:18:11 INFO - Running setup.py install for mozsystemmonitor 17:18:11 INFO - Successfully installed mozsystemmonitor 17:18:11 INFO - Cleaning up... 17:18:11 INFO - Return code: 0 17:18:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:11 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:11 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 17:18:11 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 17:18:11 INFO - Using env: {'DISPLAY': ':0', 17:18:11 INFO - 'HOME': '/home/cltbld', 17:18:11 INFO - 'LANG': 'en_US.UTF-8', 17:18:11 INFO - 'LANGUAGE': 'en_US:en', 17:18:11 INFO - 'LOGNAME': 'cltbld', 17:18:11 INFO - 'MAIL': '/var/mail/cltbld', 17:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:11 INFO - 'MOZ_NO_REMOTE': '1', 17:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:11 INFO - 'NO_EM_RESTART': '1', 17:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:11 INFO - 'PWD': '/builds/slave/test', 17:18:11 INFO - 'SHELL': '/bin/bash', 17:18:11 INFO - 'SHLVL': '1', 17:18:11 INFO - 'TERM': 'linux', 17:18:11 INFO - 'TMOUT': '86400', 17:18:11 INFO - 'USER': 'cltbld', 17:18:11 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:11 INFO - '_': '/tools/buildbot/bin/python'} 17:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:11 INFO - Downloading/unpacking jsonschema==2.5.1 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:11 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 17:18:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:18:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:18:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:18:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:18:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:18:13 INFO - warning: no files found matching '*.txt' 17:18:13 INFO - no previously-included directories found matching 'build' 17:18:13 INFO - no previously-included directories found matching 'dist' 17:18:13 INFO - no previously-included directories found matching '.git*' 17:18:13 INFO - Installing collected packages: jsonschema, functools32 17:18:13 INFO - Running setup.py install for functools32 17:18:13 INFO - warning: no files found matching '*.txt' 17:18:13 INFO - no previously-included directories found matching 'build' 17:18:13 INFO - no previously-included directories found matching 'dist' 17:18:13 INFO - no previously-included directories found matching '.git*' 17:18:13 INFO - Successfully installed jsonschema functools32 17:18:13 INFO - Cleaning up... 17:18:13 INFO - Return code: 0 17:18:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:18:13 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')]} 17:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:13 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')]} 17:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:13 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:13 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 17:18:13 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 17:18:13 INFO - Using env: {'DISPLAY': ':0', 17:18:13 INFO - 'HOME': '/home/cltbld', 17:18:13 INFO - 'LANG': 'en_US.UTF-8', 17:18:13 INFO - 'LANGUAGE': 'en_US:en', 17:18:13 INFO - 'LOGNAME': 'cltbld', 17:18:13 INFO - 'MAIL': '/var/mail/cltbld', 17:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:13 INFO - 'MOZ_NO_REMOTE': '1', 17:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:13 INFO - 'NO_EM_RESTART': '1', 17:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:13 INFO - 'PWD': '/builds/slave/test', 17:18:13 INFO - 'SHELL': '/bin/bash', 17:18:13 INFO - 'SHLVL': '1', 17:18:13 INFO - 'TERM': 'linux', 17:18:13 INFO - 'TMOUT': '86400', 17:18:13 INFO - 'USER': 'cltbld', 17:18:13 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:13 INFO - '_': '/tools/buildbot/bin/python'} 17:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:18:14 INFO - Cleaning up... 17:18:14 INFO - Return code: 0 17:18:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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', '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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:18: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 blobuploader==1.2.4 17:18:14 INFO - Using env: {'DISPLAY': ':0', 17:18:14 INFO - 'HOME': '/home/cltbld', 17:18:14 INFO - 'LANG': 'en_US.UTF-8', 17:18:14 INFO - 'LANGUAGE': 'en_US:en', 17:18:14 INFO - 'LOGNAME': 'cltbld', 17:18:14 INFO - 'MAIL': '/var/mail/cltbld', 17:18:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:14 INFO - 'MOZ_NO_REMOTE': '1', 17:18:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:14 INFO - 'NO_EM_RESTART': '1', 17:18:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:14 INFO - 'PWD': '/builds/slave/test', 17:18:14 INFO - 'SHELL': '/bin/bash', 17:18:14 INFO - 'SHLVL': '1', 17:18:14 INFO - 'TERM': 'linux', 17:18:14 INFO - 'TMOUT': '86400', 17:18:14 INFO - 'USER': 'cltbld', 17:18:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:14 INFO - '_': '/tools/buildbot/bin/python'} 17:18:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:14 INFO - Downloading/unpacking blobuploader==1.2.4 17:18:14 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 17:18:14 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 17:18:14 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 17:18:14 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 17:18:14 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 17:18:14 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 17:18:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:18:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:18:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 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 17:18:16 INFO - Downloading docopt-0.6.1.tar.gz 17:18:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:18:16 INFO - Installing collected packages: blobuploader, requests, docopt 17:18:16 INFO - Running setup.py install for blobuploader 17:18:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:18:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:18:17 INFO - Running setup.py install for requests 17:18:17 INFO - Running setup.py install for docopt 17:18:17 INFO - Successfully installed blobuploader requests docopt 17:18:17 INFO - Cleaning up... 17:18:17 INFO - Return code: 0 17:18:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:17 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:17 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 17:18:17 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 17:18:17 INFO - Using env: {'DISPLAY': ':0', 17:18:17 INFO - 'HOME': '/home/cltbld', 17:18:17 INFO - 'LANG': 'en_US.UTF-8', 17:18:17 INFO - 'LANGUAGE': 'en_US:en', 17:18:17 INFO - 'LOGNAME': 'cltbld', 17:18:17 INFO - 'MAIL': '/var/mail/cltbld', 17:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:17 INFO - 'MOZ_NO_REMOTE': '1', 17:18:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:17 INFO - 'NO_EM_RESTART': '1', 17:18:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:17 INFO - 'PWD': '/builds/slave/test', 17:18:17 INFO - 'SHELL': '/bin/bash', 17:18:17 INFO - 'SHLVL': '1', 17:18:17 INFO - 'TERM': 'linux', 17:18:17 INFO - 'TMOUT': '86400', 17:18:17 INFO - 'USER': 'cltbld', 17:18:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:17 INFO - '_': '/tools/buildbot/bin/python'} 17:18:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:17 INFO - Running setup.py (path:/tmp/pip-OFUgpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:17 INFO - Running setup.py (path:/tmp/pip-naV65O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:17 INFO - Running setup.py (path:/tmp/pip-7Qj9yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:18 INFO - Running setup.py (path:/tmp/pip-aAXO8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:18 INFO - Running setup.py (path:/tmp/pip-rgXil2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:18 INFO - Running setup.py (path:/tmp/pip-wtg0Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:18 INFO - Running setup.py (path:/tmp/pip-aODVSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:18 INFO - Running setup.py (path:/tmp/pip-TIPqwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:18 INFO - Running setup.py (path:/tmp/pip-VWPNgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:18 INFO - Running setup.py (path:/tmp/pip-pCfRiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:18 INFO - Running setup.py (path:/tmp/pip-0lIOz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:18 INFO - Running setup.py (path:/tmp/pip-5xzfnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:18 INFO - Running setup.py (path:/tmp/pip-qIe_mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:18 INFO - Running setup.py (path:/tmp/pip-AuLN0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:18 INFO - Running setup.py (path:/tmp/pip-hfqEaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:18 INFO - Running setup.py (path:/tmp/pip-J89rDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:18 INFO - Running setup.py (path:/tmp/pip-ZZDR5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:18:19 INFO - Running setup.py install for manifestparser 17:18:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Running setup.py install for mozcrash 17:18:19 INFO - Running setup.py install for mozdebug 17:18:19 INFO - Running setup.py install for mozdevice 17:18:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Running setup.py install for mozfile 17:18:19 INFO - Running setup.py install for mozhttpd 17:18:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Running setup.py install for mozinfo 17:18:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Running setup.py install for mozInstall 17:18:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:18:19 INFO - Running setup.py install for mozleak 17:18:19 INFO - Running setup.py install for mozlog 17:18:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Running setup.py install for moznetwork 17:18:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Running setup.py install for mozprocess 17:18:20 INFO - Running setup.py install for mozprofile 17:18:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Running setup.py install for mozrunner 17:18:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Running setup.py install for mozscreenshot 17:18:20 INFO - Running setup.py install for moztest 17:18:20 INFO - Running setup.py install for mozversion 17:18:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:18:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:18:20 INFO - Cleaning up... 17:18:20 INFO - Return code: 0 17:18:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18: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')]} 17:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18: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')]} 17:18:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:20 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:20 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 17:18:20 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 17:18:20 INFO - Using env: {'DISPLAY': ':0', 17:18:20 INFO - 'HOME': '/home/cltbld', 17:18:20 INFO - 'LANG': 'en_US.UTF-8', 17:18:20 INFO - 'LANGUAGE': 'en_US:en', 17:18:20 INFO - 'LOGNAME': 'cltbld', 17:18:20 INFO - 'MAIL': '/var/mail/cltbld', 17:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:20 INFO - 'MOZ_NO_REMOTE': '1', 17:18:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:20 INFO - 'NO_EM_RESTART': '1', 17:18:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:20 INFO - 'PWD': '/builds/slave/test', 17:18:20 INFO - 'SHELL': '/bin/bash', 17:18:20 INFO - 'SHLVL': '1', 17:18:20 INFO - 'TERM': 'linux', 17:18:20 INFO - 'TMOUT': '86400', 17:18:20 INFO - 'USER': 'cltbld', 17:18:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:20 INFO - '_': '/tools/buildbot/bin/python'} 17:18:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:18:21 INFO - Running setup.py (path:/tmp/pip-glEpnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:18:21 INFO - Running setup.py (path:/tmp/pip-YXGAv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:18:21 INFO - Running setup.py (path:/tmp/pip-GteJb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:18:21 INFO - Running setup.py (path:/tmp/pip-QPmbWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:18:21 INFO - Running setup.py (path:/tmp/pip-8SOSmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:18:21 INFO - Running setup.py (path:/tmp/pip-oHd7d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:18:21 INFO - Running setup.py (path:/tmp/pip-Je4kDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:18:21 INFO - Running setup.py (path:/tmp/pip-QwVSjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:18:21 INFO - Running setup.py (path:/tmp/pip-VmqwaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:18:21 INFO - Running setup.py (path:/tmp/pip-ohhx60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:18:21 INFO - Running setup.py (path:/tmp/pip-0OlRpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:18:21 INFO - Running setup.py (path:/tmp/pip-wYRnuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:18:21 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)) 17:18:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:18:21 INFO - Running setup.py (path:/tmp/pip-JMUBUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:18:22 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)) 17:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:18:22 INFO - Running setup.py (path:/tmp/pip-WxfDiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:18:22 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)) 17:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:22 INFO - Running setup.py (path:/tmp/pip-KZiaFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:18:22 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)) 17:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:18:22 INFO - Running setup.py (path:/tmp/pip-JooKP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:18:22 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)) 17:18:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:18:22 INFO - Running setup.py (path:/tmp/pip-GMCE7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:18:22 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)) 17:18:22 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)) 17:18:22 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)) 17:18:22 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)) 17:18:22 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)) 17:18:22 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)) 17:18:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18: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 17:18:24 INFO - Downloading blessings-1.6.tar.gz 17:18:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:18:24 INFO - Installing collected packages: blessings 17:18:24 INFO - Running setup.py install for blessings 17:18:24 INFO - Successfully installed blessings 17:18:24 INFO - Cleaning up... 17:18:24 INFO - Return code: 0 17:18:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:18:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:24 INFO - Reading from file tmpfile_stdout 17:18:24 INFO - Current package versions: 17:18:24 INFO - argparse == 1.2.1 17:18:24 INFO - blessings == 1.6 17:18:24 INFO - blobuploader == 1.2.4 17:18:24 INFO - docopt == 0.6.1 17:18:24 INFO - functools32 == 3.2.3-2 17:18:24 INFO - jsonschema == 2.5.1 17:18:24 INFO - manifestparser == 1.1 17:18:24 INFO - mozInstall == 1.12 17:18:24 INFO - mozcrash == 0.17 17:18:24 INFO - mozdebug == 0.1 17:18:24 INFO - mozdevice == 0.48 17:18:24 INFO - mozfile == 1.2 17:18:24 INFO - mozhttpd == 0.7 17:18:24 INFO - mozinfo == 0.9 17:18:24 INFO - mozleak == 0.1 17:18:24 INFO - mozlog == 3.4 17:18:24 INFO - moznetwork == 0.27 17:18:24 INFO - mozprocess == 0.23 17:18:24 INFO - mozprofile == 0.28 17:18:24 INFO - mozrunner == 6.12 17:18:24 INFO - mozscreenshot == 0.1 17:18:24 INFO - mozsystemmonitor == 0.3 17:18:24 INFO - moztest == 0.7 17:18:24 INFO - mozversion == 1.4 17:18:24 INFO - psutil == 3.1.1 17:18:24 INFO - requests == 1.2.3 17:18:24 INFO - wsgiref == 0.1.2 17:18:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:18:24 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')]} 17:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:24 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')]} 17:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:24 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:24 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 17:18:24 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 17:18:24 INFO - Using env: {'DISPLAY': ':0', 17:18:24 INFO - 'HOME': '/home/cltbld', 17:18:24 INFO - 'LANG': 'en_US.UTF-8', 17:18:24 INFO - 'LANGUAGE': 'en_US:en', 17:18:24 INFO - 'LOGNAME': 'cltbld', 17:18:24 INFO - 'MAIL': '/var/mail/cltbld', 17:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:24 INFO - 'MOZ_NO_REMOTE': '1', 17:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:24 INFO - 'NO_EM_RESTART': '1', 17:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:24 INFO - 'PWD': '/builds/slave/test', 17:18:24 INFO - 'SHELL': '/bin/bash', 17:18:24 INFO - 'SHLVL': '1', 17:18:24 INFO - 'TERM': 'linux', 17:18:24 INFO - 'TMOUT': '86400', 17:18:24 INFO - 'USER': 'cltbld', 17:18:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:24 INFO - '_': '/tools/buildbot/bin/python'} 17:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 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)) 17:18:24 INFO - Cleaning up... 17:18:24 INFO - Return code: 0 17:18:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:18:24 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')]} 17:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:24 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')]} 17:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:18:24 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 0x7fa254a6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', '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 17:18:24 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 17:18:24 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 17:18:24 INFO - Using env: {'DISPLAY': ':0', 17:18:24 INFO - 'HOME': '/home/cltbld', 17:18:24 INFO - 'LANG': 'en_US.UTF-8', 17:18:24 INFO - 'LANGUAGE': 'en_US:en', 17:18:24 INFO - 'LOGNAME': 'cltbld', 17:18:24 INFO - 'MAIL': '/var/mail/cltbld', 17:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:24 INFO - 'MOZ_NO_REMOTE': '1', 17:18:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:24 INFO - 'NO_EM_RESTART': '1', 17:18:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:24 INFO - 'PWD': '/builds/slave/test', 17:18:24 INFO - 'SHELL': '/bin/bash', 17:18:24 INFO - 'SHLVL': '1', 17:18:24 INFO - 'TERM': 'linux', 17:18:24 INFO - 'TMOUT': '86400', 17:18:24 INFO - 'USER': 'cltbld', 17:18:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:24 INFO - '_': '/tools/buildbot/bin/python'} 17:18:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:18:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:18:25 INFO - Cleaning up... 17:18:25 INFO - Return code: 0 17:18:25 INFO - Running post-action listener: _resource_record_post_action 17:18:25 INFO - Running post-action listener: _start_resource_monitoring 17:18:25 INFO - Starting resource monitoring. 17:18:25 INFO - [mozharness: 2016-10-18 00:18:25.204003Z] Finished create-virtualenv step (success) 17:18:25 INFO - [mozharness: 2016-10-18 00:18:25.204508Z] Running install step. 17:18:25 INFO - Running pre-action listener: _resource_record_pre_action 17:18:25 INFO - Running main action method: install 17:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:18:25 INFO - Reading from file tmpfile_stdout 17:18:25 INFO - Detecting whether we're running mozinstall >=1.0... 17:18:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:18:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:18:25 INFO - Reading from file tmpfile_stdout 17:18:25 INFO - Output received: 17:18:25 INFO - Usage: mozinstall [options] installer 17:18:25 INFO - Options: 17:18:25 INFO - -h, --help show this help message and exit 17:18:25 INFO - -d DEST, --destination=DEST 17:18:25 INFO - Directory to install application into. [default: 17:18:25 INFO - "/builds/slave/test"] 17:18:25 INFO - --app=APP Application being installed. [default: firefox] 17:18:25 INFO - mkdir: /builds/slave/test/build/application 17:18:25 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'] 17:18:25 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 17:18:41 INFO - Reading from file tmpfile_stdout 17:18:41 INFO - Output received: 17:18:41 INFO - /builds/slave/test/build/application/firefox/firefox 17:18:41 INFO - Running post-action listener: _resource_record_post_action 17:18:41 INFO - [mozharness: 2016-10-18 00:18:41.574831Z] Finished install step (success) 17:18:41 INFO - [mozharness: 2016-10-18 00:18:41.575075Z] Running run-tests step. 17:18:41 INFO - Running pre-action listener: _resource_record_pre_action 17:18:41 INFO - Running main action method: run_tests 17:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:41 INFO - Python 2.7.3 17:18:41 INFO - Return code: 0 17:18:41 INFO - grabbing minidump binary from tooltool 17:18:41 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')]} 17:18:41 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 0x25eaf60>, '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 0x25ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ec1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:41 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 17:18:41 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 17:18:41 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 17:18:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:41 INFO - Return code: 0 17:18:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:18:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:18:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 17:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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 17:18:41 INFO - Using env: {'DISPLAY': ':0', 17:18:41 INFO - 'HOME': '/home/cltbld', 17:18:41 INFO - 'LANG': 'en_US.UTF-8', 17:18:41 INFO - 'LANGUAGE': 'en_US:en', 17:18:41 INFO - 'LOGNAME': 'cltbld', 17:18:41 INFO - 'MAIL': '/var/mail/cltbld', 17:18:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:41 INFO - 'MOZ_NO_REMOTE': '1', 17:18:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:18:41 INFO - 'NO_EM_RESTART': '1', 17:18:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:41 INFO - 'PWD': '/builds/slave/test', 17:18:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:41 INFO - 'SHELL': '/bin/bash', 17:18:41 INFO - 'SHLVL': '1', 17:18:41 INFO - 'TERM': 'linux', 17:18:41 INFO - 'TMOUT': '86400', 17:18:41 INFO - 'USER': 'cltbld', 17:18:41 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529', 17:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:41 INFO - '_': '/tools/buildbot/bin/python'} 17:18:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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 17:18:41 INFO - mozversion application_buildid: 20161017154020 17:18:41 INFO - mozversion application_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 17:18:41 INFO - mozversion application_display_name: Nightly 17:18:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:41 INFO - mozversion application_name: Firefox 17:18:41 INFO - mozversion application_remotingname: firefox 17:18:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:41 INFO - mozversion application_vendor: Mozilla 17:18:41 INFO - mozversion application_version: 52.0a1 17:18:41 INFO - mozversion platform_buildid: 20161017154020 17:18:41 INFO - mozversion platform_changeset: 47be3ae8a710b35f040dffe7403877e764ab61ac 17:18:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:41 INFO - mozversion platform_version: 52.0a1 17:18:41 INFO - using testdate: 1476749921 17:18:41 INFO - actual date: 1476749921 17:18:41 INFO - starting webserver on 'localhost:33648' 17:18:41 INFO - SUITE-START | Running 2 tests 17:18:41 INFO - TEST-START | dromaeo_css 17:18:41 INFO - operating with platform_type : linux_ 17:18:41 INFO - Initialising browser for dromaeo_css test... 17:18:41 INFO - TEST-INFO | started process 11956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Zopo9/profile http://localhost:33648/getInfo.html) 17:18:46 INFO - PROCESS | 11956 | __metrics Screen width/height:1600/1200 17:18:46 INFO - PROCESS | 11956 | colorDepth:24 17:18:46 INFO - PROCESS | 11956 | Browser inner width/height: 1024/697 17:18:46 INFO - PROCESS | 11956 | __metrics 17:18:47 INFO - PROCESS | 11956 | 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" 17:18:47 INFO - PROCESS | 11956 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:18:47 INFO - PROCESS | 11956 | console.error: PushService: 17:18:47 INFO - PROCESS | 11956 | stateChangeProcessEnqueue: Error transitioning state 17:18:47 INFO - PROCESS | 11956 | UnknownError 17:18:48 INFO - TEST-INFO | 11956: exit 0 17:18:48 INFO - Browser initialized. 17:18:48 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:48 INFO - TEST-INFO | started process 12037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2Zopo9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:19:00 INFO - PROCESS | 12037 | RSS: Main: 173916160 17:19:00 INFO - PROCESS | 12037 | 17:19:52 INFO - PROCESS | 12037 | 1476749992550 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] 17:22:05 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33648/tests/dromaeo/cssquery-ext.html) 17:22:07 INFO - PROCESS | 12037 | RSS: Main: 312664064 17:22:07 INFO - PROCESS | 12037 | 17:25:09 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-ext.html (next: http://localhost:33648/tests/dromaeo/cssquery-jquery.html) 17:25:10 INFO - PROCESS | 12037 | RSS: Main: 274792448 17:25:10 INFO - PROCESS | 12037 | 17:28:12 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33648/tests/dromaeo/cssquery-mootools.html) 17:28:13 INFO - PROCESS | 12037 | RSS: Main: 237977600 17:28:13 INFO - PROCESS | 12037 | 17:31:15 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33648/tests/dromaeo/cssquery-prototype.html) 17:31:16 INFO - PROCESS | 12037 | RSS: Main: 230260736 17:31:16 INFO - PROCESS | 12037 | 17:34:19 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33648/tests/dromaeo/cssquery-yui.html) 17:34:19 INFO - PROCESS | 12037 | RSS: Main: 219131904 17:34:19 INFO - PROCESS | 12037 | 17:37:22 INFO - PROCESS | 12037 | Cycle 1(1): loaded http://localhost:33648/tests/dromaeo/cssquery-yui.html (next: http://localhost:33648/tests/dromaeo/cssquery-dojo.html) 17:37:23 INFO - PROCESS | 12037 | RSS: Main: 303935488 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | __start_tp_report 17:37:23 INFO - PROCESS | 12037 | _x_x_mozilla_page_load 17:37:23 INFO - PROCESS | 12037 | _x_x_mozilla_page_load_details 17:37:23 INFO - PROCESS | 12037 | |i|pagename|runs| 17:37:23 INFO - PROCESS | 12037 | |0;dojo.html;2596.6234895940083;2619.2142357292805;2637.7098519162887;2665.2670515608206;2671.5725483922574;4630.5137960514085;4710.788014539346;4784.114938736337;4785.18651829189;4804.903901921964;4738;4763.666543341968;4773.1646961781635;4807.975960120203;4824.61403087753;4340.804663790137;4357.803898824561;4391.604755571998;4407.360932664762;4433.379326894237;4416.58042485965;4450.599446049855;4453.354263631772;4475.530069342721;4491.236489796726;4265.594768496988;4430.933535996963;4438;4446.933296000562;4542.841000564981;4307.1601037797645;4376.912461750779;4379.211741886459;4384.145091707119;4388.253996820548;4350.434443522322;4352.695311328208;4354.956450435487;4355.73865568067;4364.345348197764;4753.71477711335;4793.544613261734;4797.568218860284;4847.2002119650215;4865.051314993578;5149.459306772772;5170.508801663836;5174.586033117342;5175.689458632494;5242.501962313574;4915.950840491585;4958.330625365602;5172.1207394742605;5189.792408303701;5203.03743807393;4703.459102203222;4768.594669453066;4813;4813.78337974792;4862.41651001882;5231.267622532849;5267.236250743697;5269.973650131801;5275.498827611371;5283.841484755463;5004.2493625956395;5019.974900125476;5059.139946209079;5061.291419201315;5067.189249720027;4953.0589188054155;4978.65149439543;4979.925301120486;5027.296178535008;5074.644774865724;5051.217061355495;5052.898942021139;5060.949390506122;5109;5116.2069879168785;5062;5075.695458272516;5076.111680455905;5077.746112694351;5165.690058596496;4294.141171765659;4339.34909763538;4339.370791235253;4445.4220951276775;4448.666350023696;3806.5812760596314;3815.1988082502985;3839.827207775657;3840;3862.5364956205435;4419.624331931757;4424.181526417623;4472.239719247736;4477.552244775561;4481.305397663367;5145.511176438233;5146.845594632167;5175.06848767218;5189.506996835295;5193.246979187997;4277.1873344064525;4333.198358303724;4336.76147811867;4427.512973572904;4467.374567560544;4618.67669263155;4654.86035418938;4661.673682842168;4664.510226426177;4725.3384526166365;4810.374651295379;4815.085133824702;4819.927701084486;4822.445418776885;4875.341828853059;4960.826371076995;5144.819931302386;5153.45888681698;5156.845294641167;5179.611529135254;4745.383100196952;4782.736949467812;4813.9037219256115;4816.036792641416;4821.590164836029;5066.316047333563;5067.214581739836;5068.493150684902;5072.594192464668;5127.307813445286;5116.07910576085;5150.8197213098865;5155.072087024371;5158.406783219828;5211.218317252443;4838.637102217418;4838.959623680926;4904.6566740327835;4921.261810728276;4983.202687569971;4929.630277729257;4934.358533390637;4937.679050861682;4991.975040124777;4994.625403094709;4826.107170173529;4832.49258827818;4836.492168322276;4841.419029716457;4895.583875370633;4904.558589726942;4920.92618610714;4926.261060840902;4963.156263435297;5024.522670346311;4860.854174374775;4900.26496025599;4901.509849015212;4942.233953737176;4956.900861982668 17:37:23 INFO - PROCESS | 12037 | |1;ext.html;550.5265471694344;557.0029646931991;571.6284415130165;572.076097103178;589.425310322436;27272;37837.432438513446;39098.80450597747;39436.80281598588;43279.78360108203;39725.60274397255;40276;40282.19435611286;40354;40370;7588.506747061451;7732.033495813023;7736.613169341538;7742;7742.922570774276;7612.505187162845;7697.846043079135;7703.576303303316;7703.768886933401;7706.113796913371;7713.4214933880185;7733.072031356217;7752.534847909115;7763;7767.456278060538;7704.306612404855;7704.422168337397;7715.228477152268;7740.26467485588;7744.845103097963;7595.278448547379;7596.696132154707;7612.505187162817;7647.808804779869;7678.040244969379;37707.811460942794;38017.61982380169;38039.42940855889;38062.42906356407;38082;2783.3876547159593;2813.7889658275712;3079.476488996876;3259.8207098609805;3275.7706960512774;27915.58126628102;27969.860150699114;28134.15597532057;28185;28451.85774071137;3419.606745224306;3426.229098452828;3462.7056700180515;3480.63453337401;3554.8222588870453;244465;244745;244851;245576.99999999822;246173;49686.25470617944;50061.74969125204;50155.74922125366;50157.498425015285;50164.749176253885;31650.683493165234;32449.513257301158;32506.349873002408;34278.65721342804;52787.472125278255;12377.443015064344;12686.048546358876;12702.9364853177;12703.047271454678;12705.618831435071;9174.357794954423;9247.213986811197;9251.537423128817;9255;9255.490947997925;12196.512139514498;12250.326232057323;12256.509739610494;12316.81524777129;12395.62813115608;6783.38949494538;6830.59016459014;6981.685824137926;6993.300669932966;7027;782.6360742254765;847.855864503036;935.6818681648273;977.6969139566758;978.5351957819978;26599;27134;27148.457030859274;27211.863940680567;27530.587041194398;729.5768454296496;896.4755617963434;912.2337236721054;913.977150571241;937.9249660027182;13227.801582976263;14082.366293516816;14127.71744565103;14372.209528476034;14381.137131771919;341836;342564;342567;343239;345211;46833.5316646836;47186;47235.05529889383;47245.527544724115;47302;1085.630885498934;1104.861892263467;1158.6176561734776;1159.9014083802972;1160.6344001639457;24368.26895193147;27375.589366159922;27931.441371172055;28306.43387132287;28541.857290713415;39169.41245881371;39676;39694.60305396909;39707.40438893361;39755;279757;281129;282328;282816;283032;23969;24887.377815554755;24924.875375623007;25915;26091.608625871006;39312.803435982634;39343.80328098341;39779.40330894981;40340;40971.38542921799;33507.83246083754;33550.328993419505;33664.831675841466;33765.3246935055;34112.65887341095;33614.32771344608;33925.83037084799;34310.48534271938;34623.307533849686;34943.65056349506;33550.32899342048;33600.49599256062;33615.32769344648;33733.12069111985;34002.489962651074;25660.61509077328;26136.60795088037;29093.709062909948;29637.555436668037;30348.84825575858;22639.88680056655;23140.305790826304;23647.40881477908;23739.1691290804;23761.762382375953 17:37:23 INFO - PROCESS | 12037 | |2;jquery.html;339.48589291758753;341.22712057190455;356.11683026095284;358.33707640864407;371.83267529611663;12384.504619815209;15893.602659933507;15985.360585576578;16665.1667416629;16839.831601683978;16601.33594656212;16731.749023764623;16939.83060169398;17356.305747770075;17525.298988040497;4869.853904382857;4924.236743304794;5044.520770526794;5073.670211436263;5078.923816142761;4909.361782968209;4913.213885778277;4973.452920178777;5020.673656212334;5281.841544753664;5360.571154307646;5367.973160134194;5369.704666243355;5369.838904832842;5370.301860758096;5216.087184742692;5341;5346.251524786514;5434.212039254326;5483.479069488392;5303.946960530422;5309.761060752276;5311.707856067915;5312.548433383167;5317.202419637047;12032.639020829389;12212;12214.877851221463;12236.938815305866;12364;1817.7546031285872;1834.2112891456668;1861.8696691231619;1866.813318668136;1869.6821540338176;8410.663573457054;8773.912260877374;9329.72010839676;9348;9352;1593.8246792852776;1660.9169541522876;1673.6820004199285;1675.103819456585;1689.5353777711105;61810.381896180916;64660.67669661668;65328.673356633386;65565;65704.34295657078;9606.471644059504;9856.359336643238;9953.402795832273;10123.898761012442;10166.847497287547;13646.795298070538;13664.111832730841;13670.726585468235;13680.726385472235;13681.452741890413;6181.134641150243;6539.280679125292;6669.399754022162;6674.899876501856;6705.4635629150525;5848.239728835224;5930.466258036798;6058.303295121029;6101.237345331833;6103.725332359965;4202.516710578261;4253.723507972034;4277.893052673708;4363.105563359503;4383.101464199832;1738.7044202485354;1803.2852324212165;1803.5941913069455;1823.1431227323137;1825.7443957845912;700.5341447937167;815.6248125862052;825.7151282807422;908.8773015642804;948.5162567090833;16114.274857631435;16358.672826543403;16523.091229982467;16828.74756878648;17364.826351736574;860;874.8556488179506;879.3448880584006;888.7378223424106;921.0651189043126;8676.479411235347;9170.358074934824;9411.858822117674;9441;9632.977074814367;283294;288816;373265;375438;376111;75164.24835751682;77818.22181778224;78190;79002;81537.18462815415;913.456493386434;934.7663084228943;940.7271891151489;944.4050248343636;944.7024187380953;15004.549863504113;15143.772843407138;15373.69465564909;15789.921050394674;16035.35858565691;24472.755272447048;28696.426071478036;33749.325013500085;33790.324193516484;34754.478682819274;47729.522704772506;48586.27120593123;48805;48922.26616600825;51249.487505125966;7068.293170683096;7412.740554080581;7470.701171953278;7542.170361260147;7688.961555192412;8046.235607617267;10098.747531311776;10138.949305253427;10834.620788272372;11244.887551124712;8667.17661822126;9002.189802917768;9011.63953441855;9088.50092714323;9567.712968610953;8752.60613272417;8902.777430564287;9308.348415610842;9553.808923821345;9876.934976844701;8705;8938.910610894069;9026.819463610822;9653.855192171983;10086.697399078039;6548.345165483413;6782.355676210752;6796.932030679828;7229.7469588564145;7568.129665088585;8867;9136.497492637704;9240.907590924273;9276.58255378523;9775.706728798148 17:37:23 INFO - PROCESS | 12037 | |3;mootools.html;1379.503378783638;1430.2205298112528;1518.779776932345;1664.4923298393985;1705.752665863449;6826.1126053613025;7313.158986716529;7314.414846812256;7320.5241659292105;7320.5241659292105;6325.209348831396;6482.546221764478;6489.415952564268;6654.234763002256;7177.138743350805;1699.7025520533919;2005.2179649936463;2050.8359331253464;2060.64968955278;2069.617120832651;2045.8670186437907;2050.44637947754;2051.620450216707;2054.9897250513727;2056.311135769519;1677.7147884859542;1924.3072493902184;1996.3811218522233;2065.308121779206;2068.265765653194;1660.4686500319901;1952.1215453046116;2008.3774030050731;2014.8488863335162;2025.4227545149708;2003.2287569285784;2019.4850313170048;2024.8785072895673;2026.6149431608094;2029.0869108901054;7337.816554586125;7397.778066658009;7400.7779766606545;7403.22266162056;7403.481756277063;4300.483941926988;4478.843240486567;4495.303227999632;4498;4504.954950450519;2702.2433718558837;2755.2423083651956;2781.1100447856693;2796.007417366826;2804.383035732136;877.5217506458995;877.5261358866204;888.3337496877342;903.9457632542003;908.1690253418114;9654.420734755937;9717.174040206592;9765.414075155442;9777.266704997082;9784.510774461249;3810.142717888453;3957.3668213086344;4069.084455997436;4134.710570260053;4135.152293779768;8378.874316885252;8384.496930184208;8384.916150838413;8386.706465273686;8387.412881098264;4423.933640995388;4424.446944131983;4433.445819272591;4435.467743870756;4438.356438316426;3971.6425521703186;3998;3998.480197574355;4006.1386801837743;4006.6794656427414;3309.23887505875;3358.5465962094804;3392.270661807674;3405.8467368968454;3408.0968543336035;1128.4583399968062;1138.4990604134155;1138.5332013874272;1147.2198904744687;1152.39241258444;699.9815268783907;744.274332525783;762.32534207227;767.4321002458141;781.9882701759478;4337.37108119321;4865.391826021747;4936.950630493721;4960.355153829979;5263.657862239019;807.446898874273;858.8668756342777;874.8469017921966;911.6171208092617;934.765909476352;3094.412061708268;3110.0980715592677;3170.302533442639;3221.7583681224;3339.632640409553;8519.616617252239;8833.646654133763;8917.866232006525;8929.598168082452;8932.598033088527;8862;8865.512396818109;8882.955585222162;8886;8891.688790892287;6729.831754206184;6863.794086177422;6936.895946560806;6942.93057069433;6944.201416837129;4678.625709943264;4700.576948074689;4730.834420795256;4753.382060332135;4775.379200703886;8197.83604327922;8257.917420825956;8339.45793523419;8378.874316885129;8386.203310685476;8297;8388.119247478928;8433.409661323894;8471.745847624581;8481.321494280319;6401.647909364843;6417.486601071996;6432.2281326241155;6452.7741529048135;6464.741410343534;6925.3074692532355;6998.6150761708595;6998.965005175145;7003.5797852129035;7012.333828286509;6273.498120150468;6293.779717709858;6342.080398342122;6485.3838885307705;6573.704183311666;6307.369263073656;6313.242410910537;6318.210223722035;6324.114623952558;6360.141380913517;5627.324721033502;5705.657660540381;5719.942800571941;5730.341010783646;5731.254936858182;4016.256992456405;4057.3711074783455;4087;4152.397902304209;4178.477690288714;4021.2560676274984;4060.0661847774586;4067.2678917793896;4115.218108559364;4250.489941206952 17:37:23 INFO - PROCESS | 12037 | |4;prototype.html;252.7876583669717;260.47514258768587;261.14475094066916;290.08767426443836;295.50502907629726;4634.606058485025;4746.528576141399;4769.403824521934;4846.079244943458;4853.757312134392;4633.6524760642915;4667;4726.291056341551;4753.595944344735;4795.520447955203;3657.3599620066384;3703.9814800925956;3720.702343812502;3729.608391118934;3735.2257677603125;3511.4381698928178;3690.3910854709075;3691.9077023074506;3696.482492451059;3720.516332876722;3438.0889064397957;3684.926301473969;3736.1220113273357;3746.943795843051;3776.9433458498142;3735.4210097434943;3735.7758534488016;3764.360058790026;3769.9057523561855;3782;3306.537084808129;3308.602967643874;3310.2386451116136;3311.536384906115;3330.333933213367;4561.6806823522365;4653.185692503832;4656.767161641905;4695.506971767949;4707.9877826267175;4242.215190189794;4248.214080395137;4252.957470425287;4261.595148460891;4269.658427325838;4975.502449754996;4996.475370086161;5009.874753131165;5014.699118052892;5014.799408023675;3489.6859282664427;3635.63643635637;3645.85416583339;3645.981770091159;3646.8905932821795;5177.559907407875;5206.739663016872;5214.9217761733225;5215.791368345262;5229.686218826882;3700.2414505026404;3711.777293362407;3713.405855063177;3724.3110024645525;3727.347714150067;3770.057485628593;3785.3186426442953;3792.905177370533;3794.924101517954;3795.7094587840265;4176.686748493875;4237.809298581571;4274.1451709658195;4284.421603083544;4300.720453170534;4960.454350021495;4979.526944940225;4989.808560808938;4991.226359914219;4993.101241776515;1182.9290242585473;1208.8791120888018;1278.8745903604954;1299.1944994103717;1309.685675437888;873.0876234335135;895.3285036222833;903.5978989349676;914.8078903430221;920.9033051529627;4395.648348132142;4453.287474004143;4460.1525710114975;4467.709598876063;4471.776411179428;5080.949190508121;5154.664946778523;5159.329287192716;5168.483151684802;5171.974140129275;4323.524412314643;4374.365716971021;4383.671224658164;4398.604125628644;4417.602415782595;2688.9327766805986;2697.662792150981;2711.295063283521;2718.415540658768;2720.5445086878426;4775.188218002948;4786.521347865186;4791.952080479151;4792.281157826354;4798.5441383068555;5058.519440653132;5151.2530683050745;5168.9224661630105;5194.220866869924;5207.843764687065;4752.5286850838065;4764.571188592974;4765.1660959331975;4774.164521208844;4788.353572267839;5037.874053148701;5053.469385714447;5060.139776237975;5074.619403544675;5079.72061536619;4754.904901902012;4960.70235785854;5004.149294619996;5008.799648014038;5024.346834911438;4796.95203047979;4804.735739534359;4804.807807687654;4805.6155507558615;4807.495213002584;3720.516332876817;3726.7391282609956;3730.198007428416;3732.6080761519647;3749.1002159482073;4911.68074075184;5078.21287700407;5217.399999000164;5227.398849132398;5261;5037.5214354636255;5058.8870448501275;5061.886384995295;5064.366954130734;5065;5095.2676090129535;5098.566621837037;5111.878570393394;5113.693178409308;5119.3891115530605;4742.739149346819;4802.327674125555;4815.662903596714;4930.654854160174;5000;4954.380702412199;5044;5089.9745501272255;5109.4416203056935;5111.821086262112;4974.801007959641;4976.278439626306;4984.6261530384645;4985.202367621163;4995.075910956485 17:37:23 INFO - PROCESS | 12037 | |5;yui.html;634.8222497700644;654.1692051095109;654.3979538824282;719.309462915601;731.188380897204;11842.11184161188;12819;12829.80755288669;12845.678858028554;12870.806937895939;12395.938020309886;12547.435365408555;12559.058070644693;12565.434555445005;12592.181508201984;623.7847942459844;643.5848877474026;758.0107959113369;767.3669222891137;781.0315209140653;783.1072577261926;784.3019712455919;784.6037750935769;784.7410354582973;784.8194915169514;822.4736168851939;823.4647479138578;823.5923218007094;823.7446391618588;824;652.2727159217438;671.5802623360399;801.2028032108032;815.7756616930333;816.5345752920838;607.9270487541479;608.458471959956;608.504069183614;608.8234412020508;609.3053918532876;12695.873041269562;12698.174618649758;12714;12722.491100355976;12725.236485810881;11453.198276120675;11462.713432164179;11910.642680719593;12029.218100823418;12802.743945121045;11470.076869043658;11567.190296679235;11620.709482262926;11629.127815413793;11898.22661526998;4059.4519739835337;4079.7756123413496;4088.080181959065;4090.2228576570355;4128.3601041838565;66611.66694166546;67496.32503674949;67724.6613766933;67756;68545.3145468544;9913.206943444507;9989.250806189564;10004.749881253027;10044.849327260097;10112.898871011343;18100.18549165291;18146;18324.725129123075;18457.077146142638;18584.163712632962;6292.716827742763;6381.712822922979;6389.156825212735;6409.487241020801;6430.807075787734;3623.148560088377;3623.4021386471463;3632.219072899339;3634.83643236055;3646.781193128421;2620.8296460729994;2669.826461280011;2701.1086341507257;2757.1866299441713;2757.9310517236827;473.47917290980337;474.0424342827469;477.6990495987575;485.03720115570565;490.91409003424974;551.170488414941;554.2406902543541;563.3240111865778;572.3532408378588;577.3187638586425;7382.926170738331;7574.697012119564;7652.655630496641;7758.495697779739;8008.199180081945;482.7755093881292;493.9922557981749;514.3108234965165;517.7540668182659;604.0817956705782;3542.326957877995;3550;3699.963000370016;3709.7588656737767;3791.8862434127022;101867;101876;102639;103521;104907.4754626222;87814.12185878059;88040.5597972006;88315.55842220748;88517.55741221382;88938;40409.797951010056;75780.24219757732;77080.2291977073;77379.22620773833;80975.19024809677;8149.837003259783;8521.829563408573;8658.826823463622;8751.693690720795;8829.66014006276;38628;39754.80122599369;40551.391729124676;40758.38862417007;44198.116037678425;59963.40036599578;60595.697021514614;61136.694316528134;64750.35249647632;64838.35161648323;9975.401475911469;10042.447665378475;10210.948945255226;10262.897371026194;10275.948620256851;11826.704332391415;12188.20776649515;12474.251544907334;12663.303518306582;12669.873301266869;11419.31484110956;11466.426678666201;11685;12033.977111945582;12065.577704780291;11343.092552595937;11392.829107563228;11717.531298747954;11777.705557361134;12046.939765301116;11552.42237888119;11605;12129.393530323625;12804.87195128074;12829.871701282867;9074.90925090767;9514.19129374011;9645.855312170183;10005.149562286995;10427.113695335982;9285.860712089188;9783.595754288533;10057.49712514386;10326.173906087644;10337.844932326172 17:37:23 INFO - PROCESS | 12037 | __end_tp_report 17:37:23 INFO - PROCESS | 12037 | __start_cc_report 17:37:23 INFO - PROCESS | 12037 | _x_x_mozilla_cycle_collect,1355 17:37:23 INFO - PROCESS | 12037 | __end_cc_report 17:37:23 INFO - PROCESS | 12037 | __startTimestamp1476751043187__endTimestamp 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | ------- Summary: start ------- 17:37:23 INFO - PROCESS | 12037 | Number of tests: 6 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#0] dojo.html Cycles:165 Average:4724.75 Median:4832.49 stddev:495.17 (10.2%) stddev-sans-first:467.70 17:37:23 INFO - PROCESS | 12037 | Values: 2596.6 2619.2 2637.7 2665.3 2671.6 4630.5 4710.8 4784.1 4785.2 4804.9 4738.0 4763.7 4773.2 4808.0 4824.6 4340.8 4357.8 4391.6 4407.4 4433.4 4416.6 4450.6 4453.4 4475.5 4491.2 4265.6 4430.9 4438.0 4446.9 4542.8 4307.2 4376.9 4379.2 4384.1 4388.3 4350.4 4352.7 4355.0 4355.7 4364.3 4753.7 4793.5 4797.6 4847.2 4865.1 5149.5 5170.5 5174.6 5175.7 5242.5 4916.0 4958.3 5172.1 5189.8 5203.0 4703.5 4768.6 4813.0 4813.8 4862.4 5231.3 5267.2 5270.0 5275.5 5283.8 5004.2 5020.0 5059.1 5061.3 5067.2 4953.1 4978.7 4979.9 5027.3 5074.6 5051.2 5052.9 5060.9 5109.0 5116.2 5062.0 5075.7 5076.1 5077.7 5165.7 4294.1 4339.3 4339.4 4445.4 4448.7 3806.6 3815.2 3839.8 3840.0 3862.5 4419.6 4424.2 4472.2 4477.6 4481.3 5145.5 5146.8 5175.1 5189.5 5193.2 4277.2 4333.2 4336.8 4427.5 4467.4 4618.7 4654.9 4661.7 4664.5 4725.3 4810.4 4815.1 4819.9 4822.4 4875.3 4960.8 5144.8 5153.5 5156.8 5179.6 4745.4 4782.7 4813.9 4816.0 4821.6 5066.3 5067.2 5068.5 5072.6 5127.3 5116.1 5150.8 5155.1 5158.4 5211.2 4838.6 4839.0 4904.7 4921.3 4983.2 4929.6 4934.4 4937.7 4992.0 4994.6 4826.1 4832.5 4836.5 4841.4 4895.6 4904.6 4920.9 4926.3 4963.2 5024.5 4860.9 4900.3 4901.5 4942.2 4956.9 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#1] ext.html Cycles:180 Average:43436.09 Median:19043.01 stddev:76911.02 (403.9%) stddev-sans-first:77059.37 17:37:23 INFO - PROCESS | 12037 | Values: 550.5 557.0 571.6 572.1 589.4 27272.0 37837.4 39098.8 39436.8 43279.8 39725.6 40276.0 40282.2 40354.0 40370.0 7588.5 7732.0 7736.6 7742.0 7742.9 7612.5 7697.8 7703.6 7703.8 7706.1 7713.4 7733.1 7752.5 7763.0 7767.5 7704.3 7704.4 7715.2 7740.3 7744.8 7595.3 7596.7 7612.5 7647.8 7678.0 37707.8 38017.6 38039.4 38062.4 38082.0 2783.4 2813.8 3079.5 3259.8 3275.8 27915.6 27969.9 28134.2 28185.0 28451.9 3419.6 3426.2 3462.7 3480.6 3554.8 244465.0 244745.0 244851.0 245577.0 246173.0 49686.3 50061.7 50155.7 50157.5 50164.7 31650.7 32449.5 32506.3 34278.7 52787.5 12377.4 12686.0 12702.9 12703.0 12705.6 9174.4 9247.2 9251.5 9255.0 9255.5 12196.5 12250.3 12256.5 12316.8 12395.6 6783.4 6830.6 6981.7 6993.3 7027.0 782.6 847.9 935.7 977.7 978.5 26599.0 27134.0 27148.5 27211.9 27530.6 729.6 896.5 912.2 914.0 937.9 13227.8 14082.4 14127.7 14372.2 14381.1 341836.0 342564.0 342567.0 343239.0 345211.0 46833.5 47186.0 47235.1 47245.5 47302.0 1085.6 1104.9 1158.6 1159.9 1160.6 24368.3 27375.6 27931.4 28306.4 28541.9 39169.4 39676.0 39694.6 39707.4 39755.0 279757.0 281129.0 282328.0 282816.0 283032.0 23969.0 24887.4 24924.9 25915.0 26091.6 39312.8 39343.8 39779.4 40340.0 40971.4 33507.8 33550.3 33664.8 33765.3 34112.7 33614.3 33925.8 34310.5 34623.3 34943.7 33550.3 33600.5 33615.3 33733.1 34002.5 25660.6 26136.6 29093.7 29637.6 30348.8 22639.9 23140.3 23647.4 23739.2 23761.8 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#2] jquery.html Cycles:180 Average:22053.85 Median:5312.13 stddev:56856.41 (1070.3%) stddev-sans-first:56992.53 17:37:23 INFO - PROCESS | 12037 | Values: 339.5 341.2 356.1 358.3 371.8 12384.5 15893.6 15985.4 16665.2 16839.8 16601.3 16731.7 16939.8 17356.3 17525.3 4869.9 4924.2 5044.5 5073.7 5078.9 4909.4 4913.2 4973.5 5020.7 5281.8 5360.6 5368.0 5369.7 5369.8 5370.3 5216.1 5341.0 5346.3 5434.2 5483.5 5303.9 5309.8 5311.7 5312.5 5317.2 12032.6 12212.0 12214.9 12236.9 12364.0 1817.8 1834.2 1861.9 1866.8 1869.7 8410.7 8773.9 9329.7 9348.0 9352.0 1593.8 1660.9 1673.7 1675.1 1689.5 61810.4 64660.7 65328.7 65565.0 65704.3 9606.5 9856.4 9953.4 10123.9 10166.8 13646.8 13664.1 13670.7 13680.7 13681.5 6181.1 6539.3 6669.4 6674.9 6705.5 5848.2 5930.5 6058.3 6101.2 6103.7 4202.5 4253.7 4277.9 4363.1 4383.1 1738.7 1803.3 1803.6 1823.1 1825.7 700.5 815.6 825.7 908.9 948.5 16114.3 16358.7 16523.1 16828.7 17364.8 860.0 874.9 879.3 888.7 921.1 8676.5 9170.4 9411.9 9441.0 9633.0 283294.0 288816.0 373265.0 375438.0 376111.0 75164.2 77818.2 78190.0 79002.0 81537.2 913.5 934.8 940.7 944.4 944.7 15004.5 15143.8 15373.7 15789.9 16035.4 24472.8 28696.4 33749.3 33790.3 34754.5 47729.5 48586.3 48805.0 48922.3 51249.5 7068.3 7412.7 7470.7 7542.2 7689.0 8046.2 10098.7 10138.9 10834.6 11244.9 8667.2 9002.2 9011.6 9088.5 9567.7 8752.6 8902.8 9308.3 9553.8 9876.9 8705.0 8938.9 9026.8 9653.9 10086.7 6548.3 6782.4 6796.9 7229.7 7568.1 8867.0 9136.5 9240.9 9276.6 9775.7 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#3] mootools.html Cycles:180 Average:4768.86 Median:5666.49 stddev:2648.71 (46.7%) stddev-sans-first:2643.90 17:37:23 INFO - PROCESS | 12037 | Values: 1379.5 1430.2 1518.8 1664.5 1705.8 6826.1 7313.2 7314.4 7320.5 7320.5 6325.2 6482.5 6489.4 6654.2 7177.1 1699.7 2005.2 2050.8 2060.6 2069.6 2045.9 2050.4 2051.6 2055.0 2056.3 1677.7 1924.3 1996.4 2065.3 2068.3 1660.5 1952.1 2008.4 2014.8 2025.4 2003.2 2019.5 2024.9 2026.6 2029.1 7337.8 7397.8 7400.8 7403.2 7403.5 4300.5 4478.8 4495.3 4498.0 4505.0 2702.2 2755.2 2781.1 2796.0 2804.4 877.5 877.5 888.3 903.9 908.2 9654.4 9717.2 9765.4 9777.3 9784.5 3810.1 3957.4 4069.1 4134.7 4135.2 8378.9 8384.5 8384.9 8386.7 8387.4 4423.9 4424.4 4433.4 4435.5 4438.4 3971.6 3998.0 3998.5 4006.1 4006.7 3309.2 3358.5 3392.3 3405.8 3408.1 1128.5 1138.5 1138.5 1147.2 1152.4 700.0 744.3 762.3 767.4 782.0 4337.4 4865.4 4937.0 4960.4 5263.7 807.4 858.9 874.8 911.6 934.8 3094.4 3110.1 3170.3 3221.8 3339.6 8519.6 8833.6 8917.9 8929.6 8932.6 8862.0 8865.5 8883.0 8886.0 8891.7 6729.8 6863.8 6936.9 6942.9 6944.2 4678.6 4700.6 4730.8 4753.4 4775.4 8197.8 8257.9 8339.5 8378.9 8386.2 8297.0 8388.1 8433.4 8471.7 8481.3 6401.6 6417.5 6432.2 6452.8 6464.7 6925.3 6998.6 6999.0 7003.6 7012.3 6273.5 6293.8 6342.1 6485.4 6573.7 6307.4 6313.2 6318.2 6324.1 6360.1 5627.3 5705.7 5719.9 5730.3 5731.3 4016.3 4057.4 4087.0 4152.4 4178.5 4021.3 4060.1 4067.3 4115.2 4250.5 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#4] prototype.html Cycles:180 Average:4157.27 Median:4749.53 stddev:1199.84 (25.3%) stddev-sans-first:1166.87 17:37:23 INFO - PROCESS | 12037 | Values: 252.8 260.5 261.1 290.1 295.5 4634.6 4746.5 4769.4 4846.1 4853.8 4633.7 4667.0 4726.3 4753.6 4795.5 3657.4 3704.0 3720.7 3729.6 3735.2 3511.4 3690.4 3691.9 3696.5 3720.5 3438.1 3684.9 3736.1 3746.9 3776.9 3735.4 3735.8 3764.4 3769.9 3782.0 3306.5 3308.6 3310.2 3311.5 3330.3 4561.7 4653.2 4656.8 4695.5 4708.0 4242.2 4248.2 4253.0 4261.6 4269.7 4975.5 4996.5 5009.9 5014.7 5014.8 3489.7 3635.6 3645.9 3646.0 3646.9 5177.6 5206.7 5214.9 5215.8 5229.7 3700.2 3711.8 3713.4 3724.3 3727.3 3770.1 3785.3 3792.9 3794.9 3795.7 4176.7 4237.8 4274.1 4284.4 4300.7 4960.5 4979.5 4989.8 4991.2 4993.1 1182.9 1208.9 1278.9 1299.2 1309.7 873.1 895.3 903.6 914.8 920.9 4395.6 4453.3 4460.2 4467.7 4471.8 5080.9 5154.7 5159.3 5168.5 5172.0 4323.5 4374.4 4383.7 4398.6 4417.6 2688.9 2697.7 2711.3 2718.4 2720.5 4775.2 4786.5 4792.0 4792.3 4798.5 5058.5 5151.3 5168.9 5194.2 5207.8 4752.5 4764.6 4765.2 4774.2 4788.4 5037.9 5053.5 5060.1 5074.6 5079.7 4754.9 4960.7 5004.1 5008.8 5024.3 4797.0 4804.7 4804.8 4805.6 4807.5 3720.5 3726.7 3730.2 3732.6 3749.1 4911.7 5078.2 5217.4 5227.4 5261.0 5037.5 5058.9 5061.9 5064.4 5065.0 5095.3 5098.6 5111.9 5113.7 5119.4 4742.7 4802.3 4815.7 4930.7 5000.0 4954.4 5044.0 5090.0 5109.4 5111.8 4974.8 4976.3 4984.6 4985.2 4995.1 17:37:23 INFO - PROCESS | 12037 | 17:37:23 INFO - PROCESS | 12037 | [#5] yui.html Cycles:180 Average:17847.06 Median:4109.29 stddev:26172.83 (636.9%) stddev-sans-first:26214.34 17:37:23 INFO - PROCESS | 12037 | Values: 634.8 654.2 654.4 719.3 731.2 11842.1 12819.0 12829.8 12845.7 12870.8 12395.9 12547.4 12559.1 12565.4 12592.2 623.8 643.6 758.0 767.4 781.0 783.1 784.3 784.6 784.7 784.8 822.5 823.5 823.6 823.7 824.0 652.3 671.6 801.2 815.8 816.5 607.9 608.5 608.5 608.8 609.3 12695.9 12698.2 12714.0 12722.5 12725.2 11453.2 11462.7 11910.6 12029.2 12802.7 11470.1 11567.2 11620.7 11629.1 11898.2 4059.5 4079.8 4088.1 4090.2 4128.4 66611.7 67496.3 67724.7 67756.0 68545.3 9913.2 9989.3 10004.7 10044.8 10112.9 18100.2 18146.0 18324.7 18457.1 18584.2 6292.7 6381.7 6389.2 6409.5 6430.8 3623.1 3623.4 3632.2 3634.8 3646.8 2620.8 2669.8 2701.1 2757.2 2757.9 473.5 474.0 477.7 485.0 490.9 551.2 554.2 563.3 572.4 577.3 7382.9 7574.7 7652.7 7758.5 8008.2 482.8 494.0 514.3 517.8 604.1 3542.3 3550.0 3700.0 3709.8 3791.9 101867.0 101876.0 102639.0 103521.0 104907.5 87814.1 88040.6 88315.6 88517.6 88938.0 40409.8 75780.2 77080.2 77379.2 80975.2 8149.8 8521.8 8658.8 8751.7 8829.7 38628.0 39754.8 40551.4 40758.4 44198.1 59963.4 60595.7 61136.7 64750.4 64838.4 9975.4 10042.4 10210.9 10262.9 10275.9 11826.7 12188.2 12474.3 12663.3 12669.9 11419.3 11466.4 11685.0 12034.0 12065.6 11343.1 11392.8 11717.5 11777.7 12046.9 11552.4 11605.0 12129.4 12804.9 12829.9 9074.9 9514.2 9645.9 10005.1 10427.1 9285.9 9783.6 10057.5 10326.2 10337.8 17:37:23 INFO - PROCESS | 12037 | -------- Summary: end -------- 17:37:23 INFO - PROCESS | 12037 | 17:37:24 INFO - TEST-INFO | 12037: exit 0 17:37:24 INFO - TEST-OK | dromaeo_css | took 1122348ms 17:37:24 INFO - TEST-START | kraken 17:37:24 INFO - operating with platform_type : linux_ 17:37:24 INFO - Initialising browser for kraken test... 17:37:24 INFO - TEST-INFO | started process 12355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbA634/profile http://localhost:33648/getInfo.html) 17:37:28 INFO - PROCESS | 12355 | __metrics Screen width/height:1600/1200 17:37:28 INFO - PROCESS | 12355 | colorDepth:24 17:37:28 INFO - PROCESS | 12355 | Browser inner width/height: 1024/697 17:37:28 INFO - PROCESS | 12355 | __metrics 17:37:29 INFO - PROCESS | 12355 | 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" 17:37:29 INFO - PROCESS | 12355 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:30 INFO - PROCESS | 12355 | console.error: PushService: 17:37:30 INFO - PROCESS | 12355 | stateChangeProcessEnqueue: Error transitioning state 17:37:30 INFO - PROCESS | 12355 | UnknownError 17:37:30 INFO - TEST-INFO | 12355: exit 0 17:37:30 INFO - Browser initialized. 17:37:30 INFO - Running cycle 1/1 for kraken test... 17:37:30 INFO - TEST-INFO | started process 12436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprbA634/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:42 INFO - PROCESS | 12436 | RSS: Main: 174075904 17:37:42 INFO - PROCESS | 12436 | 17:37:45 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:46 INFO - PROCESS | 12436 | RSS: Main: 230359040 17:37:46 INFO - PROCESS | 12436 | 17:37:49 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-dft) 17:37:50 INFO - PROCESS | 12436 | RSS: Main: 217546752 17:37:50 INFO - PROCESS | 12436 | 17:37:53 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-fft) 17:37:53 INFO - PROCESS | 12436 | RSS: Main: 300048384 17:37:53 INFO - PROCESS | 12436 | 17:37:56 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33648/tests/kraken/driver.html?testName=audio-oscillator) 17:37:56 INFO - PROCESS | 12436 | RSS: Main: 210604032 17:37:56 INFO - PROCESS | 12436 | 17:37:59 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:59 INFO - PROCESS | 12436 | RSS: Main: 212729856 17:37:59 INFO - PROCESS | 12436 | 17:38:02 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-darkroom) 17:38:03 INFO - PROCESS | 12436 | RSS: Main: 249892864 17:38:03 INFO - PROCESS | 12436 | 17:38:06 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33648/tests/kraken/driver.html?testName=imaging-desaturate) 17:38:07 INFO - PROCESS | 12436 | RSS: Main: 248532992 17:38:07 INFO - PROCESS | 12436 | 17:38:10 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33648/tests/kraken/driver.html?testName=json-parse-financial) 17:38:10 INFO - PROCESS | 12436 | RSS: Main: 248229888 17:38:10 INFO - PROCESS | 12436 | 17:38:12 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:38:13 INFO - PROCESS | 12436 | RSS: Main: 210587648 17:38:13 INFO - PROCESS | 12436 | 17:38:15 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:38:15 INFO - PROCESS | 12436 | RSS: Main: 217681920 17:38:15 INFO - PROCESS | 12436 | 17:38:17 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:38:18 INFO - PROCESS | 12436 | RSS: Main: 226869248 17:38:18 INFO - PROCESS | 12436 | 17:38:21 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:22 INFO - PROCESS | 12436 | RSS: Main: 235319296 17:38:22 INFO - PROCESS | 12436 | 17:38:25 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:25 INFO - PROCESS | 12436 | RSS: Main: 232165376 17:38:25 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | Cycle 1(1): loaded http://localhost:33648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33648/tests/kraken/driver.html?testName=ai-astar) 17:38:27 INFO - PROCESS | 12436 | RSS: Main: 283131904 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | __start_tp_report 17:38:27 INFO - PROCESS | 12436 | _x_x_mozilla_page_load 17:38:27 INFO - PROCESS | 12436 | _x_x_mozilla_page_load_details 17:38:27 INFO - PROCESS | 12436 | |i|pagename|runs| 17:38:27 INFO - PROCESS | 12436 | |0;ai-astar;109;116;116;116;116;115;116;116;115;116 17:38:27 INFO - PROCESS | 12436 | |1;audio-beat-detection;163;134;131;165;130;129;139;128;170;134 17:38:27 INFO - PROCESS | 12436 | |2;audio-dft;160;160;160;162;161;161;162;161;162;164 17:38:27 INFO - PROCESS | 12436 | |3;audio-fft;75;75;75;106;78;76;76;78;101;77 17:38:27 INFO - PROCESS | 12436 | |4;audio-oscillator;84;82;112;84;84;83;113;83;83;117 17:38:27 INFO - PROCESS | 12436 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;117 17:38:27 INFO - PROCESS | 12436 | |6;imaging-darkroom;147;146;147;148;146;146;146;147;145;146 17:38:27 INFO - PROCESS | 12436 | |7;imaging-desaturate;85;85;84;84;84;85;84;84;85;84 17:38:27 INFO - PROCESS | 12436 | |8;json-parse-financial;63;64;65;62;64;65;64;65;64;65 17:38:27 INFO - PROCESS | 12436 | |9;json-stringify-tinderbox;67;68;67;67;68;68;68;67;67;67 17:38:27 INFO - PROCESS | 12436 | |10;stanford-crypto-aes;84;83;85;83;84;85;84;83;84;83 17:38:27 INFO - PROCESS | 12436 | |11;stanford-crypto-ccm;141;145;147;146;163;139;143;158;187;138 17:38:27 INFO - PROCESS | 12436 | |12;stanford-crypto-pbkdf2;180;180;176;177;176;175;186;180;182;181 17:38:27 INFO - PROCESS | 12436 | |13;stanford-crypto-sha256-iterative;71;71;73;70;70;71;69;70;71;69 17:38:27 INFO - PROCESS | 12436 | __end_tp_report 17:38:27 INFO - PROCESS | 12436 | __start_cc_report 17:38:27 INFO - PROCESS | 12436 | _x_x_mozilla_cycle_collect,2012 17:38:27 INFO - PROCESS | 12436 | __end_cc_report 17:38:27 INFO - PROCESS | 12436 | __startTimestamp1476751107739__endTimestamp 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | ------- Summary: start ------- 17:38:27 INFO - PROCESS | 12436 | Number of tests: 14 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:2.18 (1.9%) stddev-sans-first:0.44 17:38:27 INFO - PROCESS | 12436 | Values: 109.0 116.0 116.0 116.0 116.0 115.0 116.0 116.0 115.0 116.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:136.50 stddev:16.73 (12.3%) stddev-sans-first:15.98 17:38:27 INFO - PROCESS | 12436 | Values: 163.0 134.0 131.0 165.0 130.0 129.0 139.0 128.0 170.0 134.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.24 17:38:27 INFO - PROCESS | 12436 | Values: 160.0 160.0 160.0 162.0 161.0 161.0 162.0 161.0 162.0 164.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.61 (15.3%) stddev-sans-first:12.05 17:38:27 INFO - PROCESS | 12436 | Values: 75.0 75.0 75.0 106.0 78.0 76.0 76.0 78.0 101.0 77.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:83.00 stddev:14.90 (18.0%) stddev-sans-first:15.48 17:38:27 INFO - PROCESS | 12436 | Values: 84.0 82.0 112.0 84.0 84.0 83.0 113.0 83.0 83.0 117.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:38:27 INFO - PROCESS | 12436 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 17:38:27 INFO - PROCESS | 12436 | Values: 147.0 146.0 147.0 148.0 146.0 146.0 146.0 147.0 145.0 146.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 17:38:27 INFO - PROCESS | 12436 | Values: 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 84.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:0.99 (1.5%) stddev-sans-first:0.97 17:38:27 INFO - PROCESS | 12436 | Values: 63.0 64.0 65.0 62.0 64.0 65.0 64.0 65.0 64.0 65.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 17:38:27 INFO - PROCESS | 12436 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 67.0 67.0 67.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.83 17:38:27 INFO - PROCESS | 12436 | Values: 84.0 83.0 85.0 83.0 84.0 85.0 84.0 83.0 84.0 83.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#11] stanford-crypto-ccm Cycles:10 Average:150.70 Median:146.50 stddev:15.06 (10.3%) stddev-sans-first:15.56 17:38:27 INFO - PROCESS | 12436 | Values: 141.0 145.0 147.0 146.0 163.0 139.0 143.0 158.0 187.0 138.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:180.00 stddev:3.37 (1.9%) stddev-sans-first:3.56 17:38:27 INFO - PROCESS | 12436 | Values: 180.0 180.0 176.0 177.0 176.0 175.0 186.0 180.0 182.0 181.0 17:38:27 INFO - PROCESS | 12436 | 17:38:27 INFO - PROCESS | 12436 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:71.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 17:38:27 INFO - PROCESS | 12436 | Values: 71.0 71.0 73.0 70.0 70.0 71.0 69.0 70.0 71.0 69.0 17:38:27 INFO - PROCESS | 12436 | -------- Summary: end -------- 17:38:27 INFO - PROCESS | 12436 | 17:38:29 INFO - TEST-INFO | 12436: exit 0 17:38:29 INFO - TEST-OK | kraken | took 64957ms 17:38:29 INFO - SUITE-END | took 1187s 17:38:29 INFO - Completed test suite (00:19:47) 17:38:29 INFO - javascript benchmark 17:38:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.6234895940083, 2619.2142357292805, 2637.7098519162887, 2665.2670515608206, 2671.5725483922574, 4630.5137960514085, 4710.788014539346, 4784.114938736337, 4785.18651829189, 4804.903901921964, 4738.0, 4763.666543341968, 4773.1646961781635, 4807.975960120203, 4824.61403087753, 4340.804663790137, 4357.803898824561, 4391.604755571998, 4407.360932664762, 4433.379326894237, 4416.58042485965, 4450.599446049855, 4453.354263631772, 4475.530069342721, 4491.236489796726, 4265.594768496988, 4430.933535996963, 4438.0, 4446.933296000562, 4542.841000564981, 4307.1601037797645, 4376.912461750779, 4379.211741886459, 4384.145091707119, 4388.253996820548, 4350.434443522322, 4352.695311328208, 4354.956450435487, 4355.73865568067, 4364.345348197764, 4753.71477711335, 4793.544613261734, 4797.568218860284, 4847.2002119650215, 4865.051314993578, 5149.459306772772, 5170.508801663836, 5174.586033117342, 5175.689458632494, 5242.501962313574, 4915.950840491585, 4958.330625365602, 5172.1207394742605, 5189.792408303701, 5203.03743807393, 4703.459102203222, 4768.594669453066, 4813.0, 4813.78337974792, 4862.41651001882, 5231.267622532849, 5267.236250743697, 5269.973650131801, 5275.498827611371, 5283.841484755463, 5004.2493625956395, 5019.974900125476, 5059.139946209079, 5061.291419201315, 5067.189249720027, 4953.0589188054155, 4978.65149439543, 4979.925301120486, 5027.296178535008, 5074.644774865724, 5051.217061355495, 5052.898942021139, 5060.949390506122, 5109.0, 5116.2069879168785, 5062.0, 5075.695458272516, 5076.111680455905, 5077.746112694351, 5165.690058596496, 4294.141171765659, 4339.34909763538, 4339.370791235253, 4445.4220951276775, 4448.666350023696, 3806.5812760596314, 3815.1988082502985, 3839.827207775657, 3840.0, 3862.5364956205435, 4419.624331931757, 4424.181526417623, 4472.239719247736, 4477.552244775561, 4481.305397663367, 5145.511176438233, 5146.845594632167, 5175.06848767218, 5189.506996835295, 5193.246979187997, 4277.1873344064525, 4333.198358303724, 4336.76147811867, 4427.512973572904, 4467.374567560544, 4618.67669263155, 4654.86035418938, 4661.673682842168, 4664.510226426177, 4725.3384526166365, 4810.374651295379, 4815.085133824702, 4819.927701084486, 4822.445418776885, 4875.341828853059, 4960.826371076995, 5144.819931302386, 5153.45888681698, 5156.845294641167, 5179.611529135254, 4745.383100196952, 4782.736949467812, 4813.9037219256115, 4816.036792641416, 4821.590164836029, 5066.316047333563, 5067.214581739836, 5068.493150684902, 5072.594192464668, 5127.307813445286, 5116.07910576085, 5150.8197213098865, 5155.072087024371, 5158.406783219828, 5211.218317252443, 4838.637102217418, 4838.959623680926, 4904.6566740327835, 4921.261810728276, 4983.202687569971, 4929.630277729257, 4934.358533390637, 4937.679050861682, 4991.975040124777, 4994.625403094709, 4826.107170173529, 4832.49258827818, 4836.492168322276, 4841.419029716457, 4895.583875370633, 4904.558589726942, 4920.92618610714, 4926.261060840902, 4963.156263435297, 5024.522670346311, 4860.854174374775, 4900.26496025599, 4901.509849015212, 4942.233953737176, 4956.900861982668], "value": 4692.876943991137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5265471694344, 557.0029646931991, 571.6284415130165, 572.076097103178, 589.425310322436, 27272.0, 37837.432438513446, 39098.80450597747, 39436.80281598588, 43279.78360108203, 39725.60274397255, 40276.0, 40282.19435611286, 40354.0, 40370.0, 7588.506747061451, 7732.033495813023, 7736.613169341538, 7742.0, 7742.922570774276, 7612.505187162845, 7697.846043079135, 7703.576303303316, 7703.768886933401, 7706.113796913371, 7713.4214933880185, 7733.072031356217, 7752.534847909115, 7763.0, 7767.456278060538, 7704.306612404855, 7704.422168337397, 7715.228477152268, 7740.26467485588, 7744.845103097963, 7595.278448547379, 7596.696132154707, 7612.505187162817, 7647.808804779869, 7678.040244969379, 37707.811460942794, 38017.61982380169, 38039.42940855889, 38062.42906356407, 38082.0, 2783.3876547159593, 2813.7889658275712, 3079.476488996876, 3259.8207098609805, 3275.7706960512774, 27915.58126628102, 27969.860150699114, 28134.15597532057, 28185.0, 28451.85774071137, 3419.606745224306, 3426.229098452828, 3462.7056700180515, 3480.63453337401, 3554.8222588870453, 244465.0, 244745.0, 244851.0, 245576.99999999822, 246173.0, 49686.25470617944, 50061.74969125204, 50155.74922125366, 50157.498425015285, 50164.749176253885, 31650.683493165234, 32449.513257301158, 32506.349873002408, 34278.65721342804, 52787.472125278255, 12377.443015064344, 12686.048546358876, 12702.9364853177, 12703.047271454678, 12705.618831435071, 9174.357794954423, 9247.213986811197, 9251.537423128817, 9255.0, 9255.490947997925, 12196.512139514498, 12250.326232057323, 12256.509739610494, 12316.81524777129, 12395.62813115608, 6783.38949494538, 6830.59016459014, 6981.685824137926, 6993.300669932966, 7027.0, 782.6360742254765, 847.855864503036, 935.6818681648273, 977.6969139566758, 978.5351957819978, 26599.0, 27134.0, 27148.457030859274, 27211.863940680567, 27530.587041194398, 729.5768454296496, 896.4755617963434, 912.2337236721054, 913.977150571241, 937.9249660027182, 13227.801582976263, 14082.366293516816, 14127.71744565103, 14372.209528476034, 14381.137131771919, 341836.0, 342564.0, 342567.0, 343239.0, 345211.0, 46833.5316646836, 47186.0, 47235.05529889383, 47245.527544724115, 47302.0, 1085.630885498934, 1104.861892263467, 1158.6176561734776, 1159.9014083802972, 1160.6344001639457, 24368.26895193147, 27375.589366159922, 27931.441371172055, 28306.43387132287, 28541.857290713415, 39169.41245881371, 39676.0, 39694.60305396909, 39707.40438893361, 39755.0, 279757.0, 281129.0, 282328.0, 282816.0, 283032.0, 23969.0, 24887.377815554755, 24924.875375623007, 25915.0, 26091.608625871006, 39312.803435982634, 39343.80328098341, 39779.40330894981, 40340.0, 40971.38542921799, 33507.83246083754, 33550.328993419505, 33664.831675841466, 33765.3246935055, 34112.65887341095, 33614.32771344608, 33925.83037084799, 34310.48534271938, 34623.307533849686, 34943.65056349506, 33550.32899342048, 33600.49599256062, 33615.32769344648, 33733.12069111985, 34002.489962651074, 25660.61509077328, 26136.60795088037, 29093.709062909948, 29637.555436668037, 30348.84825575858, 22639.88680056655, 23140.305790826304, 23647.40881477908, 23739.1691290804, 23761.762382375953], "value": 16372.000843544982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.48589291758753, 341.22712057190455, 356.11683026095284, 358.33707640864407, 371.83267529611663, 12384.504619815209, 15893.602659933507, 15985.360585576578, 16665.1667416629, 16839.831601683978, 16601.33594656212, 16731.749023764623, 16939.83060169398, 17356.305747770075, 17525.298988040497, 4869.853904382857, 4924.236743304794, 5044.520770526794, 5073.670211436263, 5078.923816142761, 4909.361782968209, 4913.213885778277, 4973.452920178777, 5020.673656212334, 5281.841544753664, 5360.571154307646, 5367.973160134194, 5369.704666243355, 5369.838904832842, 5370.301860758096, 5216.087184742692, 5341.0, 5346.251524786514, 5434.212039254326, 5483.479069488392, 5303.946960530422, 5309.761060752276, 5311.707856067915, 5312.548433383167, 5317.202419637047, 12032.639020829389, 12212.0, 12214.877851221463, 12236.938815305866, 12364.0, 1817.7546031285872, 1834.2112891456668, 1861.8696691231619, 1866.813318668136, 1869.6821540338176, 8410.663573457054, 8773.912260877374, 9329.72010839676, 9348.0, 9352.0, 1593.8246792852776, 1660.9169541522876, 1673.6820004199285, 1675.103819456585, 1689.5353777711105, 61810.381896180916, 64660.67669661668, 65328.673356633386, 65565.0, 65704.34295657078, 9606.471644059504, 9856.359336643238, 9953.402795832273, 10123.898761012442, 10166.847497287547, 13646.795298070538, 13664.111832730841, 13670.726585468235, 13680.726385472235, 13681.452741890413, 6181.134641150243, 6539.280679125292, 6669.399754022162, 6674.899876501856, 6705.4635629150525, 5848.239728835224, 5930.466258036798, 6058.303295121029, 6101.237345331833, 6103.725332359965, 4202.516710578261, 4253.723507972034, 4277.893052673708, 4363.105563359503, 4383.101464199832, 1738.7044202485354, 1803.2852324212165, 1803.5941913069455, 1823.1431227323137, 1825.7443957845912, 700.5341447937167, 815.6248125862052, 825.7151282807422, 908.8773015642804, 948.5162567090833, 16114.274857631435, 16358.672826543403, 16523.091229982467, 16828.74756878648, 17364.826351736574, 860.0, 874.8556488179506, 879.3448880584006, 888.7378223424106, 921.0651189043126, 8676.479411235347, 9170.358074934824, 9411.858822117674, 9441.0, 9632.977074814367, 283294.0, 288816.0, 373265.0, 375438.0, 376111.0, 75164.24835751682, 77818.22181778224, 78190.0, 79002.0, 81537.18462815415, 913.456493386434, 934.7663084228943, 940.7271891151489, 944.4050248343636, 944.7024187380953, 15004.549863504113, 15143.772843407138, 15373.69465564909, 15789.921050394674, 16035.35858565691, 24472.755272447048, 28696.426071478036, 33749.325013500085, 33790.324193516484, 34754.478682819274, 47729.522704772506, 48586.27120593123, 48805.0, 48922.26616600825, 51249.487505125966, 7068.293170683096, 7412.740554080581, 7470.701171953278, 7542.170361260147, 7688.961555192412, 8046.235607617267, 10098.747531311776, 10138.949305253427, 10834.620788272372, 11244.887551124712, 8667.17661822126, 9002.189802917768, 9011.63953441855, 9088.50092714323, 9567.712968610953, 8752.60613272417, 8902.777430564287, 9308.348415610842, 9553.808923821345, 9876.934976844701, 8705.0, 8938.910610894069, 9026.819463610822, 9653.855192171983, 10086.697399078039, 6548.345165483413, 6782.355676210752, 6796.932030679828, 7229.7469588564145, 7568.129665088585, 8867.0, 9136.497492637704, 9240.907590924273, 9276.58255378523, 9775.706728798148], "value": 7703.389407492419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.503378783638, 1430.2205298112528, 1518.779776932345, 1664.4923298393985, 1705.752665863449, 6826.1126053613025, 7313.158986716529, 7314.414846812256, 7320.5241659292105, 7320.5241659292105, 6325.209348831396, 6482.546221764478, 6489.415952564268, 6654.234763002256, 7177.138743350805, 1699.7025520533919, 2005.2179649936463, 2050.8359331253464, 2060.64968955278, 2069.617120832651, 2045.8670186437907, 2050.44637947754, 2051.620450216707, 2054.9897250513727, 2056.311135769519, 1677.7147884859542, 1924.3072493902184, 1996.3811218522233, 2065.308121779206, 2068.265765653194, 1660.4686500319901, 1952.1215453046116, 2008.3774030050731, 2014.8488863335162, 2025.4227545149708, 2003.2287569285784, 2019.4850313170048, 2024.8785072895673, 2026.6149431608094, 2029.0869108901054, 7337.816554586125, 7397.778066658009, 7400.7779766606545, 7403.22266162056, 7403.481756277063, 4300.483941926988, 4478.843240486567, 4495.303227999632, 4498.0, 4504.954950450519, 2702.2433718558837, 2755.2423083651956, 2781.1100447856693, 2796.007417366826, 2804.383035732136, 877.5217506458995, 877.5261358866204, 888.3337496877342, 903.9457632542003, 908.1690253418114, 9654.420734755937, 9717.174040206592, 9765.414075155442, 9777.266704997082, 9784.510774461249, 3810.142717888453, 3957.3668213086344, 4069.084455997436, 4134.710570260053, 4135.152293779768, 8378.874316885252, 8384.496930184208, 8384.916150838413, 8386.706465273686, 8387.412881098264, 4423.933640995388, 4424.446944131983, 4433.445819272591, 4435.467743870756, 4438.356438316426, 3971.6425521703186, 3998.0, 3998.480197574355, 4006.1386801837743, 4006.6794656427414, 3309.23887505875, 3358.5465962094804, 3392.270661807674, 3405.8467368968454, 3408.0968543336035, 1128.4583399968062, 1138.4990604134155, 1138.5332013874272, 1147.2198904744687, 1152.39241258444, 699.9815268783907, 744.274332525783, 762.32534207227, 767.4321002458141, 781.9882701759478, 4337.37108119321, 4865.391826021747, 4936.950630493721, 4960.355153829979, 5263.657862239019, 807.446898874273, 858.8668756342777, 874.8469017921966, 911.6171208092617, 934.765909476352, 3094.412061708268, 3110.0980715592677, 3170.302533442639, 3221.7583681224, 3339.632640409553, 8519.616617252239, 8833.646654133763, 8917.866232006525, 8929.598168082452, 8932.598033088527, 8862.0, 8865.512396818109, 8882.955585222162, 8886.0, 8891.688790892287, 6729.831754206184, 6863.794086177422, 6936.895946560806, 6942.93057069433, 6944.201416837129, 4678.625709943264, 4700.576948074689, 4730.834420795256, 4753.382060332135, 4775.379200703886, 8197.83604327922, 8257.917420825956, 8339.45793523419, 8378.874316885129, 8386.203310685476, 8297.0, 8388.119247478928, 8433.409661323894, 8471.745847624581, 8481.321494280319, 6401.647909364843, 6417.486601071996, 6432.2281326241155, 6452.7741529048135, 6464.741410343534, 6925.3074692532355, 6998.6150761708595, 6998.965005175145, 7003.5797852129035, 7012.333828286509, 6273.498120150468, 6293.779717709858, 6342.080398342122, 6485.3838885307705, 6573.704183311666, 6307.369263073656, 6313.242410910537, 6318.210223722035, 6324.114623952558, 6360.141380913517, 5627.324721033502, 5705.657660540381, 5719.942800571941, 5730.341010783646, 5731.254936858182, 4016.256992456405, 4057.3711074783455, 4087.0, 4152.397902304209, 4178.477690288714, 4021.2560676274984, 4060.0661847774586, 4067.2678917793896, 4115.218108559364, 4250.489941206952], "value": 3860.704100498748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.7876583669717, 260.47514258768587, 261.14475094066916, 290.08767426443836, 295.50502907629726, 4634.606058485025, 4746.528576141399, 4769.403824521934, 4846.079244943458, 4853.757312134392, 4633.6524760642915, 4667.0, 4726.291056341551, 4753.595944344735, 4795.520447955203, 3657.3599620066384, 3703.9814800925956, 3720.702343812502, 3729.608391118934, 3735.2257677603125, 3511.4381698928178, 3690.3910854709075, 3691.9077023074506, 3696.482492451059, 3720.516332876722, 3438.0889064397957, 3684.926301473969, 3736.1220113273357, 3746.943795843051, 3776.9433458498142, 3735.4210097434943, 3735.7758534488016, 3764.360058790026, 3769.9057523561855, 3782.0, 3306.537084808129, 3308.602967643874, 3310.2386451116136, 3311.536384906115, 3330.333933213367, 4561.6806823522365, 4653.185692503832, 4656.767161641905, 4695.506971767949, 4707.9877826267175, 4242.215190189794, 4248.214080395137, 4252.957470425287, 4261.595148460891, 4269.658427325838, 4975.502449754996, 4996.475370086161, 5009.874753131165, 5014.699118052892, 5014.799408023675, 3489.6859282664427, 3635.63643635637, 3645.85416583339, 3645.981770091159, 3646.8905932821795, 5177.559907407875, 5206.739663016872, 5214.9217761733225, 5215.791368345262, 5229.686218826882, 3700.2414505026404, 3711.777293362407, 3713.405855063177, 3724.3110024645525, 3727.347714150067, 3770.057485628593, 3785.3186426442953, 3792.905177370533, 3794.924101517954, 3795.7094587840265, 4176.686748493875, 4237.809298581571, 4274.1451709658195, 4284.421603083544, 4300.720453170534, 4960.454350021495, 4979.526944940225, 4989.808560808938, 4991.226359914219, 4993.101241776515, 1182.9290242585473, 1208.8791120888018, 1278.8745903604954, 1299.1944994103717, 1309.685675437888, 873.0876234335135, 895.3285036222833, 903.5978989349676, 914.8078903430221, 920.9033051529627, 4395.648348132142, 4453.287474004143, 4460.1525710114975, 4467.709598876063, 4471.776411179428, 5080.949190508121, 5154.664946778523, 5159.329287192716, 5168.483151684802, 5171.974140129275, 4323.524412314643, 4374.365716971021, 4383.671224658164, 4398.604125628644, 4417.602415782595, 2688.9327766805986, 2697.662792150981, 2711.295063283521, 2718.415540658768, 2720.5445086878426, 4775.188218002948, 4786.521347865186, 4791.952080479151, 4792.281157826354, 4798.5441383068555, 5058.519440653132, 5151.2530683050745, 5168.9224661630105, 5194.220866869924, 5207.843764687065, 4752.5286850838065, 4764.571188592974, 4765.1660959331975, 4774.164521208844, 4788.353572267839, 5037.874053148701, 5053.469385714447, 5060.139776237975, 5074.619403544675, 5079.72061536619, 4754.904901902012, 4960.70235785854, 5004.149294619996, 5008.799648014038, 5024.346834911438, 4796.95203047979, 4804.735739534359, 4804.807807687654, 4805.6155507558615, 4807.495213002584, 3720.516332876817, 3726.7391282609956, 3730.198007428416, 3732.6080761519647, 3749.1002159482073, 4911.68074075184, 5078.21287700407, 5217.399999000164, 5227.398849132398, 5261.0, 5037.5214354636255, 5058.8870448501275, 5061.886384995295, 5064.366954130734, 5065.0, 5095.2676090129535, 5098.566621837037, 5111.878570393394, 5113.693178409308, 5119.3891115530605, 4742.739149346819, 4802.327674125555, 4815.662903596714, 4930.654854160174, 5000.0, 4954.380702412199, 5044.0, 5089.9745501272255, 5109.4416203056935, 5111.821086262112, 4974.801007959641, 4976.278439626306, 4984.6261530384645, 4985.202367621163, 4995.075910956485], "value": 3770.349559711054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.8222497700644, 654.1692051095109, 654.3979538824282, 719.309462915601, 731.188380897204, 11842.11184161188, 12819.0, 12829.80755288669, 12845.678858028554, 12870.806937895939, 12395.938020309886, 12547.435365408555, 12559.058070644693, 12565.434555445005, 12592.181508201984, 623.7847942459844, 643.5848877474026, 758.0107959113369, 767.3669222891137, 781.0315209140653, 783.1072577261926, 784.3019712455919, 784.6037750935769, 784.7410354582973, 784.8194915169514, 822.4736168851939, 823.4647479138578, 823.5923218007094, 823.7446391618588, 824.0, 652.2727159217438, 671.5802623360399, 801.2028032108032, 815.7756616930333, 816.5345752920838, 607.9270487541479, 608.458471959956, 608.504069183614, 608.8234412020508, 609.3053918532876, 12695.873041269562, 12698.174618649758, 12714.0, 12722.491100355976, 12725.236485810881, 11453.198276120675, 11462.713432164179, 11910.642680719593, 12029.218100823418, 12802.743945121045, 11470.076869043658, 11567.190296679235, 11620.709482262926, 11629.127815413793, 11898.22661526998, 4059.4519739835337, 4079.7756123413496, 4088.080181959065, 4090.2228576570355, 4128.3601041838565, 66611.66694166546, 67496.32503674949, 67724.6613766933, 67756.0, 68545.3145468544, 9913.206943444507, 9989.250806189564, 10004.749881253027, 10044.849327260097, 10112.898871011343, 18100.18549165291, 18146.0, 18324.725129123075, 18457.077146142638, 18584.163712632962, 6292.716827742763, 6381.712822922979, 6389.156825212735, 6409.487241020801, 6430.807075787734, 3623.148560088377, 3623.4021386471463, 3632.219072899339, 3634.83643236055, 3646.781193128421, 2620.8296460729994, 2669.826461280011, 2701.1086341507257, 2757.1866299441713, 2757.9310517236827, 473.47917290980337, 474.0424342827469, 477.6990495987575, 485.03720115570565, 490.91409003424974, 551.170488414941, 554.2406902543541, 563.3240111865778, 572.3532408378588, 577.3187638586425, 7382.926170738331, 7574.697012119564, 7652.655630496641, 7758.495697779739, 8008.199180081945, 482.7755093881292, 493.9922557981749, 514.3108234965165, 517.7540668182659, 604.0817956705782, 3542.326957877995, 3550.0, 3699.963000370016, 3709.7588656737767, 3791.8862434127022, 101867.0, 101876.0, 102639.0, 103521.0, 104907.4754626222, 87814.12185878059, 88040.5597972006, 88315.55842220748, 88517.55741221382, 88938.0, 40409.797951010056, 75780.24219757732, 77080.2291977073, 77379.22620773833, 80975.19024809677, 8149.837003259783, 8521.829563408573, 8658.826823463622, 8751.693690720795, 8829.66014006276, 38628.0, 39754.80122599369, 40551.391729124676, 40758.38862417007, 44198.116037678425, 59963.40036599578, 60595.697021514614, 61136.694316528134, 64750.35249647632, 64838.35161648323, 9975.401475911469, 10042.447665378475, 10210.948945255226, 10262.897371026194, 10275.948620256851, 11826.704332391415, 12188.20776649515, 12474.251544907334, 12663.303518306582, 12669.873301266869, 11419.31484110956, 11466.426678666201, 11685.0, 12033.977111945582, 12065.577704780291, 11343.092552595937, 11392.829107563228, 11717.531298747954, 11777.705557361134, 12046.939765301116, 11552.42237888119, 11605.0, 12129.393530323625, 12804.87195128074, 12829.871701282867, 9074.90925090767, 9514.19129374011, 9645.855312170183, 10005.149562286995, 10427.113695335982, 9285.860712089188, 9783.595754288533, 10057.49712514386, 10326.173906087644, 10337.844932326172], "value": 6456.486715073461, "unit": "score"}], "name": "dromaeo_css", "value": 6178.541484267088, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 116.0, 116.0, 115.0, 116.0, 116.0, 115.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 134.0, 131.0, 165.0, 130.0, 129.0, 139.0, 128.0, 170.0, 134.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 164.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 78.0, 76.0, 76.0, 78.0, 101.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 112.0, 84.0, 84.0, 83.0, 113.0, 83.0, 83.0, 117.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 62.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 83.0, 84.0, 85.0, 84.0, 83.0, 84.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 145.0, 147.0, 146.0, 163.0, 139.0, 143.0, 158.0, 187.0, 138.0], "value": 150.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 176.0, 177.0, 176.0, 175.0, 186.0, 180.0, 182.0, 181.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 70.0, 70.0, 71.0, 69.0, 70.0, 71.0, 69.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1556.3, "alertThreshold": 2.0}]} 17:38:29 INFO - Return code: 0 17:38:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:38:29 INFO - # TBPL SUCCESS # 17:38:29 INFO - Running post-action listener: _resource_record_post_action 17:38:29 INFO - [mozharness: 2016-10-18 00:38:29.526981Z] Finished run-tests step (success) 17:38:29 INFO - Running post-run listener: _resource_record_post_run 17:38:29 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398770176; Read time: 16; Write time: 275336 17:38:29 INFO - TinderboxPrint: CPU usage
13.0% 17:38:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:38:29 INFO - TinderboxPrint: I/O write bytes / time
398,770,176 / 275,336 17:38:29 INFO - TinderboxPrint: CPU idle
8,355.7 (87.0%) 17:38:29 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 17:38:29 INFO - TinderboxPrint: Swap in / out
0 / 0 17:38:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108822528; Read time: 0; Write time: 93068 17:38:29 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289947648; Read time: 16; Write time: 182268 17:38:30 INFO - Running post-run listener: _upload_blobber_files 17:38:30 INFO - Blob upload gear active. 17:38:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:30 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 17:38:30 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:30 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:30 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:38:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:38:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:31 INFO - (blobuploader) - INFO - Done attempting. 17:38:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:38:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:35 INFO - (blobuploader) - INFO - Done attempting. 17:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:35 INFO - (blobuploader) - INFO - Done attempting. 17:38:35 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:35 INFO - Return code: 0 17:38:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00f2da33fd1403038572238abb48d25aa711fc263f1ba3e4b71af34efbbe6da237048d5965ad68c9bd0b1332519a30c1ac74a389b90db2b6929b5c24dbe0c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4efb36be003d9e1f3cd61846128a4ab2f0fd02097a924573a4b823abbeea66e8b225e32633dc2afa30a005560406a78d3177bff113d7296094e8e5cf0a466460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98ca95ad776765bc2116ac528b12e9fb2d43204fad94f7744f1703a403eac4851dd3bcad2759ab4a1d74f73ca5529d27fd8e0a9a2cca1eef9bc7f8f2f8f0b623"} 17:38:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:35 INFO - Contents: 17:38:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/00f2da33fd1403038572238abb48d25aa711fc263f1ba3e4b71af34efbbe6da237048d5965ad68c9bd0b1332519a30c1ac74a389b90db2b6929b5c24dbe0c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4efb36be003d9e1f3cd61846128a4ab2f0fd02097a924573a4b823abbeea66e8b225e32633dc2afa30a005560406a78d3177bff113d7296094e8e5cf0a466460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98ca95ad776765bc2116ac528b12e9fb2d43204fad94f7744f1703a403eac4851dd3bcad2759ab4a1d74f73ca5529d27fd8e0a9a2cca1eef9bc7f8f2f8f0b623"} 17:38:35 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:35 INFO - Copying logs to upload dir... 17:38:35 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.051010 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-10-17 17:38:35.482661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:38:35.486021) ========= 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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 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-Non-PGO/sha512/00f2da33fd1403038572238abb48d25aa711fc263f1ba3e4b71af34efbbe6da237048d5965ad68c9bd0b1332519a30c1ac74a389b90db2b6929b5c24dbe0c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4efb36be003d9e1f3cd61846128a4ab2f0fd02097a924573a4b823abbeea66e8b225e32633dc2afa30a005560406a78d3177bff113d7296094e8e5cf0a466460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98ca95ad776765bc2116ac528b12e9fb2d43204fad94f7744f1703a403eac4851dd3bcad2759ab4a1d74f73ca5529d27fd8e0a9a2cca1eef9bc7f8f2f8f0b623"} build_url:https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/WrU7-H-VRnK3_8WmG0vuAw/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-Non-PGO/sha512/00f2da33fd1403038572238abb48d25aa711fc263f1ba3e4b71af34efbbe6da237048d5965ad68c9bd0b1332519a30c1ac74a389b90db2b6929b5c24dbe0c682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4efb36be003d9e1f3cd61846128a4ab2f0fd02097a924573a4b823abbeea66e8b225e32633dc2afa30a005560406a78d3177bff113d7296094e8e5cf0a466460", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/98ca95ad776765bc2116ac528b12e9fb2d43204fad94f7744f1703a403eac4851dd3bcad2759ab4a1d74f73ca5529d27fd8e0a9a2cca1eef9bc7f8f2f8f0b623"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 17:38:35.510526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:38:35.510849) ========= 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=cbe409c6de289db6ac707de3000001d4-1476749801.926885-211182529 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 17:38:35.595470) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:38:35.595782) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 17:38:35.596063) ========= ========= Total master_lag: 0.16 =========