builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0086 starttime: 1461298309.3 results: success (0) buildid: 20160421190312 builduid: 9459e8c0827640cf82c92739e7d3bb46 revision: 4fa5909cf1e73939ee823442f2c69b0a86474489 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 21:11:49.302473) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 21:11:49.302947) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 43 secs) (at 2016-04-21 21:11:49.303223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 43 secs) (at 2016-04-21 21:12:32.682110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-21 21:12:32.682489) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-21 21:12:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-04-21 21:12:33 (14.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.482427 ========= master_lag: 7.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-04-21 21:12:40.545528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 15 secs) (at 2016-04-21 21:12:40.545856) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020025 ========= master_lag: 15.40 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 15 secs) (at 2016-04-21 21:12:55.966828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-04-21 21:12:55.967165) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4fa5909cf1e73939ee823442f2c69b0a86474489 --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 4fa5909cf1e73939ee823442f2c69b0a86474489 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-21 21:12:57,819 truncating revision to first 12 chars 2016-04-21 21:12:57,820 Setting DEBUG logging. 2016-04-21 21:12:57,820 attempt 1/10 2016-04-21 21:12:57,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4fa5909cf1e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 21:12:58,100 unpacking tar archive at: fx-team-4fa5909cf1e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530203 ========= master_lag: 14.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 14 secs) (at 2016-04-21 21:13:10.778668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 21:13:10.778965) ========= script_repo_revision: 4fa5909cf1e73939ee823442f2c69b0a86474489 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 21:13:10.779341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 19 secs) (at 2016-04-21 21:13:10.780146) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 19 secs) (at 2016-04-21 21:13:30.568387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 33 mins, 33 secs) (at 2016-04-21 21:13:30.568654) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:13:30 INFO - MultiFileLogger online at 20160421 21:13:30 in /builds/slave/test 21:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:13:30 INFO - {'append_to_log': False, 21:13:30 INFO - 'base_work_dir': '/builds/slave/test', 21:13:30 INFO - 'blob_upload_branch': 'Fx-Team', 21:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:13:30 INFO - 'branch': 'Fx-Team', 21:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:13:30 INFO - 'config_files': ('talos/mac_config.py',), 21:13:30 INFO - 'default_actions': ('clobber', 21:13:30 INFO - 'read-buildbot-config', 21:13:30 INFO - 'download-and-extract', 21:13:30 INFO - 'populate-webroot', 21:13:30 INFO - 'create-virtualenv', 21:13:30 INFO - 'install', 21:13:30 INFO - 'run-tests'), 21:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:13:30 INFO - 'download_minidump_stackwalk': True, 21:13:30 INFO - 'download_symbols': 'ondemand', 21:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:13:30 INFO - 'installer_path': 'installer.exe', 21:13:30 INFO - 'log_level': 'info', 21:13:30 INFO - 'log_name': 'talos', 21:13:30 INFO - 'log_to_console': True, 21:13:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:13:30 INFO - 'opt_config_files': (), 21:13:30 INFO - 'pip_index': False, 21:13:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:30 INFO - 'cmd': ('bash', 21:13:30 INFO - '-c', 21:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:30 INFO - 'enabled': True, 21:13:30 INFO - 'halt_on_failure': False, 21:13:30 INFO - 'name': 'check_screen_resolution'},), 21:13:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:13:30 INFO - 'cmd': ('bash', 21:13:30 INFO - '-c', 21:13:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:13:30 INFO - 'enabled': True, 21:13:30 INFO - 'halt_on_failure': False, 21:13:30 INFO - 'name': 'check_screen_resolution'},), 21:13:30 INFO - 'run_cmd_checks_enabled': True, 21:13:30 INFO - 'sps_profile': False, 21:13:30 INFO - 'sps_profile_interval': 0, 21:13:30 INFO - 'suite': 'dromaeojs-e10s', 21:13:30 INFO - 'system_bits': '32', 21:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:13:30 INFO - 'title': 't-yosemite-r7-0086', 21:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:13:30 INFO - 'use_talos_json': True, 21:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:13:30 INFO - 'work_dir': 'build'} 21:13:30 INFO - ##### 21:13:30 INFO - ##### Running clobber step. 21:13:30 INFO - ##### 21:13:30 INFO - Running pre-action listener: _resource_record_pre_action 21:13:30 INFO - Running main action method: clobber 21:13:30 INFO - rmtree: /builds/slave/test/build 21:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:13:32 INFO - Running post-action listener: _resource_record_post_action 21:13:32 INFO - ##### 21:13:32 INFO - ##### Running read-buildbot-config step. 21:13:32 INFO - ##### 21:13:32 INFO - Running pre-action listener: _resource_record_pre_action 21:13:32 INFO - Running main action method: read_buildbot_config 21:13:32 INFO - Using buildbot properties: 21:13:32 INFO - { 21:13:32 INFO - "project": "", 21:13:32 INFO - "product": "firefox", 21:13:32 INFO - "script_repo_revision": "production", 21:13:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:13:32 INFO - "repository": "", 21:13:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:13:32 INFO - "buildid": "20160421190312", 21:13:32 INFO - "pgo_build": "False", 21:13:32 INFO - "basedir": "/builds/slave/test", 21:13:32 INFO - "buildnumber": 621, 21:13:32 INFO - "slavename": "t-yosemite-r7-0086", 21:13:32 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:13:32 INFO - "platform": "yosemite_r7", 21:13:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:13:32 INFO - "branch": "fx-team", 21:13:32 INFO - "repo_path": "integration/fx-team", 21:13:32 INFO - "revision": "4fa5909cf1e73939ee823442f2c69b0a86474489", 21:13:32 INFO - "stage_platform": "macosx64", 21:13:32 INFO - "builduid": "9459e8c0827640cf82c92739e7d3bb46", 21:13:32 INFO - "slavebuilddir": "test" 21:13:32 INFO - } 21:13:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:13:32 INFO - Running post-action listener: _resource_record_post_action 21:13:32 INFO - ##### 21:13:32 INFO - ##### Running download-and-extract step. 21:13:32 INFO - ##### 21:13:32 INFO - Running pre-action listener: _resource_record_pre_action 21:13:32 INFO - Running main action method: download_and_extract 21:13:32 INFO - mkdir: /builds/slave/test/build/tests 21:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:32 INFO - https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:13:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:13:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:13:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 21:13:33 INFO - Downloaded 1199 bytes. 21:13:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:13:33 INFO - Using the following test package requirements: 21:13:33 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:13:33 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:13:33 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:13:33 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'jsshell-mac.zip'], 21:13:33 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:13:33 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:13:33 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:13:33 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:13:33 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:13:33 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:13:33 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:13:33 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:33 INFO - https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:13:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:34 INFO - Downloaded 18105795 bytes. 21:13:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:13:38 INFO - Return code: 0 21:13:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 21:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:38 INFO - https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:13:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:13:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 21:13:39 INFO - Downloaded 18105795 bytes. 21:13:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 21:13:42 INFO - Return code: 0 21:13:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:42 INFO - https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:13:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:13:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:13:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:13:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 21:13:43 INFO - Downloaded 10845952 bytes. 21:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:13:44 INFO - Return code: 0 21:13:44 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:44 INFO - https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:13:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:13:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:13:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 21:13:48 INFO - Downloaded 110032103 bytes. 21:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:13:48 INFO - mkdir: /builds/slave/test/properties 21:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:48 INFO - Contents: 21:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:13:50 INFO - Running post-action listener: _resource_record_post_action 21:13:50 INFO - Running post-action listener: set_extra_try_arguments 21:13:50 INFO - ##### 21:13:50 INFO - ##### Running populate-webroot step. 21:13:50 INFO - ##### 21:13:50 INFO - Running pre-action listener: _resource_record_pre_action 21:13:50 INFO - Running main action method: populate_webroot 21:13:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:50 INFO - '--tppagecycles', 21:13:50 INFO - '7'], 21:13:50 INFO - 'tests': ['tsvgm']}}, 21:13:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:13:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:13:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:13:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['damp', 'tps']}, 21:13:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'tests': ['damp', 'tps']}, 21:13:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['dromaeo_dom']}, 21:13:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'other-e10s': {'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['a11yr', 21:13:50 INFO - 'ts_paint', 21:13:50 INFO - 'tpaint', 21:13:50 INFO - 'sessionrestore', 21:13:50 INFO - 'sessionrestore_no_auto_restore', 21:13:50 INFO - 'tabpaint']}, 21:13:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['tsvgx', 21:13:50 INFO - 'tsvgr_opacity', 21:13:50 INFO - 'tart', 21:13:50 INFO - 'tscrollx', 21:13:50 INFO - 'cart']}, 21:13:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:13:50 INFO - 'tsvgr_opacity', 21:13:50 INFO - 'tart', 21:13:50 INFO - 'tscrollx', 21:13:50 INFO - 'cart']}, 21:13:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'talos_options': ['--disable-e10s'], 21:13:50 INFO - 'tests': ['tp5o']}, 21:13:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'tests': ['tp5o']}, 21:13:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'talos_options': ['--disable-e10s', 21:13:50 INFO - '--xperf_path', 21:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:50 INFO - 'tests': ['tp5n']}, 21:13:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:50 INFO - 'talos_options': ['--xperf_path', 21:13:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:50 INFO - 'tests': ['tp5n']}}, 21:13:50 INFO - 'talos.zip': {'path': '', 21:13:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:50 INFO - Running post-action listener: _resource_record_post_action 21:13:50 INFO - ##### 21:13:50 INFO - ##### Running create-virtualenv step. 21:13:50 INFO - ##### 21:13:50 INFO - Running pre-action listener: _resource_record_pre_action 21:13:50 INFO - Running main action method: create_virtualenv 21:13:50 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:50 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 21:13:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:50 INFO - Using real prefix '/tools/python27' 21:13:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:53 INFO - Installing pip.................done. 21:13:53 INFO - Return code: 0 21:13:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:53 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:53 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 21:13:53 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 21:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:53 INFO - 'HOME': '/Users/cltbld', 21:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:53 INFO - 'LOGNAME': 'cltbld', 21:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:53 INFO - 'MOZ_NO_REMOTE': '1', 21:13:53 INFO - 'NO_EM_RESTART': '1', 21:13:53 INFO - 'PAGER': '/bin/cat', 21:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:53 INFO - 'PWD': '/builds/slave/test', 21:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:53 INFO - 'SHELL': '/bin/bash', 21:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:13:53 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:53 INFO - 'USER': 'cltbld', 21:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:53 INFO - 'XPC_FLAGS': '0x0', 21:13:53 INFO - 'XPC_SERVICE_NAME': '0', 21:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:54 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 21:13:54 INFO - Cleaning up... 21:13:54 INFO - Return code: 0 21:13:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:13:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:54 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:54 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>=0.7.1'] in /builds/slave/test/build 21:13:54 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>=0.7.1 21:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:54 INFO - 'HOME': '/Users/cltbld', 21:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:54 INFO - 'LOGNAME': 'cltbld', 21:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:54 INFO - 'MOZ_NO_REMOTE': '1', 21:13:54 INFO - 'NO_EM_RESTART': '1', 21:13:54 INFO - 'PAGER': '/bin/cat', 21:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:54 INFO - 'PWD': '/builds/slave/test', 21:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:54 INFO - 'SHELL': '/bin/bash', 21:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:13:54 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:54 INFO - 'USER': 'cltbld', 21:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:54 INFO - 'XPC_FLAGS': '0x0', 21:13:54 INFO - 'XPC_SERVICE_NAME': '0', 21:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:54 INFO - Downloading/unpacking psutil>=0.7.1 21:13:54 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 21:13:54 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 21:13:54 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 21:13:54 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 21:13:54 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 21:13:54 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 21:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:57 INFO - Installing collected packages: psutil 21:13:57 INFO - Running setup.py install for psutil 21:13:57 INFO - building 'psutil._psutil_osx' extension 21:13:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 21:13:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 21:13:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 21:13:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 21:13:57 INFO - building 'psutil._psutil_posix' extension 21:13:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 21:13:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:13:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:13:58 INFO - ^ 21:13:58 INFO - 1 warning generated. 21:13:58 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 21:13:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:58 INFO - Successfully installed psutil 21:13:58 INFO - Cleaning up... 21:13:58 INFO - Return code: 0 21:13:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:58 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:58 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.0.0'] in /builds/slave/test/build 21:13:58 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.0.0 21:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:58 INFO - 'HOME': '/Users/cltbld', 21:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:58 INFO - 'LOGNAME': 'cltbld', 21:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:58 INFO - 'MOZ_NO_REMOTE': '1', 21:13:58 INFO - 'NO_EM_RESTART': '1', 21:13:58 INFO - 'PAGER': '/bin/cat', 21:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:58 INFO - 'PWD': '/builds/slave/test', 21:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:58 INFO - 'SHELL': '/bin/bash', 21:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:13:58 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:58 INFO - 'USER': 'cltbld', 21:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:58 INFO - 'XPC_FLAGS': '0x0', 21:13:58 INFO - 'XPC_SERVICE_NAME': '0', 21:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:13:58 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 21:13:58 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 21:13:58 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 21:13:58 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 21:13:58 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 21:13:58 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 21:14:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:14:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:14:01 INFO - Installing collected packages: mozsystemmonitor 21:14:01 INFO - Running setup.py install for mozsystemmonitor 21:14:01 INFO - Successfully installed mozsystemmonitor 21:14:01 INFO - Cleaning up... 21:14:01 INFO - Return code: 0 21:14:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:01 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:01 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 21:14:01 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 21:14:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:01 INFO - 'HOME': '/Users/cltbld', 21:14:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:01 INFO - 'LOGNAME': 'cltbld', 21:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:01 INFO - 'MOZ_NO_REMOTE': '1', 21:14:01 INFO - 'NO_EM_RESTART': '1', 21:14:01 INFO - 'PAGER': '/bin/cat', 21:14:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:01 INFO - 'PWD': '/builds/slave/test', 21:14:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:01 INFO - 'SHELL': '/bin/bash', 21:14:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:01 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:01 INFO - 'USER': 'cltbld', 21:14:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:01 INFO - 'XPC_FLAGS': '0x0', 21:14:01 INFO - 'XPC_SERVICE_NAME': '0', 21:14:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:01 INFO - Downloading/unpacking blobuploader==1.2.4 21:14:01 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 21:14:01 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 21:14:01 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 21:14:01 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 21:14:01 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 21:14:01 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 21:14:03 INFO - Downloading blobuploader-1.2.4.tar.gz 21:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:14:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:14:03 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 21:14:03 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 21:14:03 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 21:14:03 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 21:14:03 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 21:14:03 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 21:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:14:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:14:04 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 21:14:04 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 21:14:04 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 21:14:04 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 21:14:04 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 21:14:04 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 21:14:05 INFO - Downloading docopt-0.6.1.tar.gz 21:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:14:05 INFO - Installing collected packages: blobuploader, requests, docopt 21:14:05 INFO - Running setup.py install for blobuploader 21:14:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:14:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:14:05 INFO - Running setup.py install for requests 21:14:05 INFO - Running setup.py install for docopt 21:14:05 INFO - Successfully installed blobuploader requests docopt 21:14:05 INFO - Cleaning up... 21:14:06 INFO - Return code: 0 21:14:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:06 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:06 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 21:14:06 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 21:14:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:06 INFO - 'HOME': '/Users/cltbld', 21:14:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:06 INFO - 'LOGNAME': 'cltbld', 21:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:06 INFO - 'MOZ_NO_REMOTE': '1', 21:14:06 INFO - 'NO_EM_RESTART': '1', 21:14:06 INFO - 'PAGER': '/bin/cat', 21:14:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:06 INFO - 'PWD': '/builds/slave/test', 21:14:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:06 INFO - 'SHELL': '/bin/bash', 21:14:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:06 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:06 INFO - 'USER': 'cltbld', 21:14:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:06 INFO - 'XPC_FLAGS': '0x0', 21:14:06 INFO - 'XPC_SERVICE_NAME': '0', 21:14:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-WRGFPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-5KhsLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-8Vo79N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gbR7cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-13c1iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-VqnxYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:06 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-x26DrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-O7L5tm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-EekEKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wn4C_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rClFuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-wc8fQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DtxZRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-91_3sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-hdFnYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:07 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-p99jV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:08 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TSJoG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:14:08 INFO - Running setup.py install for manifestparser 21:14:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:14:08 INFO - Running setup.py install for mozcrash 21:14:08 INFO - Running setup.py install for mozdebug 21:14:08 INFO - Running setup.py install for mozdevice 21:14:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:14:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:14:08 INFO - Running setup.py install for mozfile 21:14:08 INFO - Running setup.py install for mozhttpd 21:14:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Running setup.py install for mozinfo 21:14:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Running setup.py install for mozInstall 21:14:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Running setup.py install for mozleak 21:14:09 INFO - Running setup.py install for mozlog 21:14:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Running setup.py install for moznetwork 21:14:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:14:09 INFO - Running setup.py install for mozprocess 21:14:09 INFO - Running setup.py install for mozprofile 21:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:14:10 INFO - Running setup.py install for mozrunner 21:14:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:14:10 INFO - Running setup.py install for mozscreenshot 21:14:10 INFO - Running setup.py install for moztest 21:14:10 INFO - Running setup.py install for mozversion 21:14:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:14:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:14:10 INFO - Cleaning up... 21:14:10 INFO - Return code: 0 21:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:10 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:10 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:10 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 21:14:10 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 21:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:10 INFO - 'HOME': '/Users/cltbld', 21:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:10 INFO - 'LOGNAME': 'cltbld', 21:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:10 INFO - 'MOZ_NO_REMOTE': '1', 21:14:10 INFO - 'NO_EM_RESTART': '1', 21:14:10 INFO - 'PAGER': '/bin/cat', 21:14:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:10 INFO - 'PWD': '/builds/slave/test', 21:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:10 INFO - 'SHELL': '/bin/bash', 21:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:10 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:10 INFO - 'USER': 'cltbld', 21:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:10 INFO - 'XPC_FLAGS': '0x0', 21:14:10 INFO - 'XPC_SERVICE_NAME': '0', 21:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rlnlyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-DMw5n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-gKidXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-eNMkdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-X8iWNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-V8t7zV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KkNhyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-j8Ddij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-TSCfoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:14:11 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)) 21:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:14:11 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KR5iVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-d6l3IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:14:12 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-Jmvq4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-mDahIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:14:12 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-KtKf_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-kBpGQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:14:12 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-FC1mKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:14:12 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)) 21:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:14:12 INFO - Running setup.py (path:/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/pip-rMrcUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:14:12 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)) 21:14:12 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)) 21:14:12 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)) 21:14:12 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)) 21:14:12 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)) 21:14:12 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)) 21:14:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:14:12 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 21:14:12 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 21:14:12 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 21:14:12 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 21:14:12 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 21:14:12 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 21:14:15 INFO - Downloading blessings-1.6.tar.gz 21:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:14:15 INFO - Installing collected packages: blessings 21:14:15 INFO - Running setup.py install for blessings 21:14:15 INFO - Successfully installed blessings 21:14:15 INFO - Cleaning up... 21:14:15 INFO - Return code: 0 21:14:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:15 INFO - Reading from file tmpfile_stdout 21:14:15 INFO - Current package versions: 21:14:15 INFO - blessings == 1.6 21:14:15 INFO - blobuploader == 1.2.4 21:14:15 INFO - docopt == 0.6.1 21:14:15 INFO - manifestparser == 1.1 21:14:15 INFO - mozInstall == 1.12 21:14:15 INFO - mozcrash == 0.17 21:14:15 INFO - mozdebug == 0.1 21:14:15 INFO - mozdevice == 0.48 21:14:15 INFO - mozfile == 1.2 21:14:15 INFO - mozhttpd == 0.7 21:14:15 INFO - mozinfo == 0.9 21:14:15 INFO - mozleak == 0.1 21:14:15 INFO - mozlog == 3.1 21:14:15 INFO - moznetwork == 0.27 21:14:15 INFO - mozprocess == 0.22 21:14:15 INFO - mozprofile == 0.28 21:14:15 INFO - mozrunner == 6.11 21:14:15 INFO - mozscreenshot == 0.1 21:14:15 INFO - mozsystemmonitor == 0.0 21:14:15 INFO - moztest == 0.7 21:14:15 INFO - mozversion == 1.4 21:14:15 INFO - psutil == 3.1.1 21:14:15 INFO - requests == 1.2.3 21:14:15 INFO - wsgiref == 0.1.2 21:14:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:15 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:15 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 21:14:15 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 21:14:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:15 INFO - 'HOME': '/Users/cltbld', 21:14:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:15 INFO - 'LOGNAME': 'cltbld', 21:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:15 INFO - 'MOZ_NO_REMOTE': '1', 21:14:15 INFO - 'NO_EM_RESTART': '1', 21:14:15 INFO - 'PAGER': '/bin/cat', 21:14:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:15 INFO - 'PWD': '/builds/slave/test', 21:14:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:15 INFO - 'SHELL': '/bin/bash', 21:14:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:15 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:15 INFO - 'USER': 'cltbld', 21:14:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:15 INFO - 'XPC_FLAGS': '0x0', 21:14:15 INFO - 'XPC_SERVICE_NAME': '0', 21:14:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 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)) 21:14:16 INFO - Cleaning up... 21:14:16 INFO - Return code: 0 21:14:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:14:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:16 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 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:16 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 21:14:16 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 21:14:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:16 INFO - 'HOME': '/Users/cltbld', 21:14:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:16 INFO - 'LOGNAME': 'cltbld', 21:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:16 INFO - 'MOZ_NO_REMOTE': '1', 21:14:16 INFO - 'NO_EM_RESTART': '1', 21:14:16 INFO - 'PAGER': '/bin/cat', 21:14:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:16 INFO - 'PWD': '/builds/slave/test', 21:14:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:16 INFO - 'SHELL': '/bin/bash', 21:14:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:16 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:16 INFO - 'USER': 'cltbld', 21:14:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:16 INFO - 'XPC_FLAGS': '0x0', 21:14:16 INFO - 'XPC_SERVICE_NAME': '0', 21:14:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:16 INFO - Downloading/unpacking jsonschema 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:14:18 INFO - Downloading/unpacking functools32 (from jsonschema) 21:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:19 INFO - Downloading functools32-3.2.3-2.tar.gz 21:14:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:14:19 INFO - warning: no files found matching '*.txt' 21:14:19 INFO - no previously-included directories found matching 'build' 21:14:19 INFO - no previously-included directories found matching 'dist' 21:14:19 INFO - no previously-included directories found matching '.git*' 21:14:19 INFO - Installing collected packages: jsonschema, functools32 21:14:19 INFO - Running setup.py install for functools32 21:14:19 INFO - warning: no files found matching '*.txt' 21:14:19 INFO - no previously-included directories found matching 'build' 21:14:19 INFO - no previously-included directories found matching 'dist' 21:14:19 INFO - no previously-included directories found matching '.git*' 21:14:19 INFO - Successfully installed jsonschema functools32 21:14:19 INFO - Cleaning up... 21:14:19 INFO - Return code: 0 21:14:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:14:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:14:19 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbca5c70f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:14:19 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', 'flake8'] in /builds/slave/test/build 21:14:19 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 flake8 21:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:19 INFO - 'HOME': '/Users/cltbld', 21:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:19 INFO - 'LOGNAME': 'cltbld', 21:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:19 INFO - 'MOZ_NO_REMOTE': '1', 21:14:19 INFO - 'NO_EM_RESTART': '1', 21:14:19 INFO - 'PAGER': '/bin/cat', 21:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:19 INFO - 'PWD': '/builds/slave/test', 21:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:19 INFO - 'SHELL': '/bin/bash', 21:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:19 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:19 INFO - 'USER': 'cltbld', 21:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:19 INFO - 'XPC_FLAGS': '0x0', 21:14:19 INFO - 'XPC_SERVICE_NAME': '0', 21:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:14:19 INFO - Downloading/unpacking flake8 21:14:19 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 21:14:19 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 21:14:19 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 21:14:19 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 21:14:19 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 21:14:19 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 21:14:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:14:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:14:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14: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 21:14:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:14:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:14:23 INFO - no previously-included directories found matching 'docs/_build' 21:14:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:14:23 INFO - Running setup.py install for pep8 21:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:14:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:14:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:14:23 INFO - no previously-included directories found matching 'docs/_build' 21:14:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:14:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:14:23 INFO - Cleaning up... 21:14:23 INFO - Return code: 0 21:14:23 INFO - Running post-action listener: _resource_record_post_action 21:14:23 INFO - Running post-action listener: _start_resource_monitoring 21:14:23 INFO - Starting resource monitoring. 21:14:23 INFO - ##### 21:14:23 INFO - ##### Running install step. 21:14:23 INFO - ##### 21:14:23 INFO - Running pre-action listener: _resource_record_pre_action 21:14:23 INFO - Running main action method: install 21:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:14:24 INFO - Reading from file tmpfile_stdout 21:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:14:24 INFO - Reading from file tmpfile_stdout 21:14:24 INFO - Output received: 21:14:24 INFO - Usage: mozinstall [options] installer 21:14:24 INFO - Options: 21:14:24 INFO - -h, --help show this help message and exit 21:14:24 INFO - -d DEST, --destination=DEST 21:14:24 INFO - Directory to install application into. [default: 21:14:24 INFO - "/builds/slave/test"] 21:14:24 INFO - --app=APP Application being installed. [default: firefox] 21:14:24 INFO - mkdir: /builds/slave/test/build/application 21:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 21:14:58 INFO - Reading from file tmpfile_stdout 21:14:58 INFO - Output received: 21:14:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:14:58 INFO - Running post-action listener: _resource_record_post_action 21:14:58 INFO - ##### 21:14:58 INFO - ##### Running run-tests step. 21:14:58 INFO - ##### 21:14:58 INFO - Running pre-action listener: _resource_record_pre_action 21:14:58 INFO - Running main action method: run_tests 21:14:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:58 INFO - 2016-04-21 21:14:58.019 screenresolution[1922:14826] starting screenresolution argv=screenresolution get 21:14:58 INFO - 2016-04-21 21:14:58.022 screenresolution[1922:14826] Display 0: 1600x1200x32@60 21:14:58 INFO - 2016-04-21 21:14:58.027 screenresolution[1923:14828] starting screenresolution argv=screenresolution list 21:14:58 INFO - Available Modes on Display 0 21:14:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:58 INFO - Intel Iris: 21:14:58 INFO - Chipset Model: Intel Iris 21:14:58 INFO - Type: GPU 21:14:58 INFO - Bus: Built-In 21:14:58 INFO - VRAM (Dynamic, Max): 1536 MB 21:14:58 INFO - Vendor: Intel (0x8086) 21:14:58 INFO - Device ID: 0x0a2e 21:14:58 INFO - Revision ID: 0x0009 21:14:58 INFO - Displays: 21:14:58 INFO - Display: 21:14:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:58 INFO - Display Serial Number: 1600x1200 60 21:14:58 INFO - Main Display: Yes 21:14:58 INFO - Mirror: Off 21:14:58 INFO - Online: Yes 21:14:58 INFO - Rotation: Supported 21:14:58 INFO - Return code: 0 21:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:58 INFO - Python 2.7.3 21:14:58 INFO - Return code: 0 21:14:58 INFO - grabbing minidump binary from tooltool 21:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:58 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101debe00>, '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 0x101c54db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101de6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:58 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:14:58 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 21:14:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:58 INFO - Return code: 0 21:14:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:14:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:14:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:14:59 INFO - Return code: 0 21:14:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:14:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:14:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render', 21:14:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:59 INFO - 'HOME': '/Users/cltbld', 21:14:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:59 INFO - 'LOGNAME': 'cltbld', 21:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:59 INFO - 'MOZ_NO_REMOTE': '1', 21:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:59 INFO - 'NO_EM_RESTART': '1', 21:14:59 INFO - 'PAGER': '/bin/cat', 21:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:59 INFO - 'PWD': '/builds/slave/test', 21:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:59 INFO - 'SHELL': '/bin/bash', 21:14:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners', 21:14:59 INFO - 'TMPDIR': '/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/', 21:14:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:59 INFO - 'USER': 'cltbld', 21:14:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:59 INFO - 'XPC_FLAGS': '0x0', 21:14:59 INFO - 'XPC_SERVICE_NAME': '0', 21:14:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:14:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:14:59 INFO - mozversion application_buildid: 20160421190312 21:14:59 INFO - mozversion application_changeset: 4fa5909cf1e73939ee823442f2c69b0a86474489 21:14:59 INFO - mozversion application_display_name: Nightly 21:14:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:59 INFO - mozversion application_name: Firefox 21:14:59 INFO - mozversion application_remotingname: firefox 21:14:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:14:59 INFO - mozversion application_vendor: Mozilla 21:14:59 INFO - mozversion application_version: 48.0a1 21:14:59 INFO - mozversion platform_buildid: 20160421190312 21:14:59 INFO - mozversion platform_changeset: 4fa5909cf1e73939ee823442f2c69b0a86474489 21:14:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:14:59 INFO - mozversion platform_version: 48.0a1 21:14:59 INFO - using testdate: 1461298499 21:14:59 INFO - actual date: 1461298499 21:14:59 INFO - starting webserver on 'localhost:51154' 21:14:59 INFO - SUITE-START | Running 2 tests 21:14:59 INFO - TEST-START | dromaeo_css 21:14:59 INFO - operating with platform_type : mac_ 21:14:59 INFO - Initialising browser for dromaeo_css test... 21:14:59 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKLtPmU/profile http://localhost:51154/getInfo.html) 21:15:02 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 21:15:02 INFO - PROCESS | 1941 | colorDepth:24 21:15:02 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 21:15:02 INFO - PROCESS | 1941 | __metrics 21:15:02 ERROR - PROCESS | 1941 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:15:03 INFO - TEST-INFO | 1941: exit 0 21:15:03 INFO - Browser initialized. 21:15:03 INFO - Running cycle 1/1 for dromaeo_css test... 21:15:03 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpKLtPmU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:15:15 INFO - PROCESS | 1944 | RSS: Main: 247640064 21:15:15 INFO - PROCESS | 1944 | 21:16:04 INFO - PROCESS | 1944 | 1461298564865 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] 21:18:15 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51154/tests/dromaeo/cssquery-ext.html) 21:18:17 INFO - PROCESS | 1944 | RSS: Main: 259760128 21:18:17 INFO - PROCESS | 1944 | 21:21:19 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-ext.html (next: http://localhost:51154/tests/dromaeo/cssquery-jquery.html) 21:21:20 INFO - PROCESS | 1944 | RSS: Main: 272322560 21:21:20 INFO - PROCESS | 1944 | 21:24:21 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51154/tests/dromaeo/cssquery-mootools.html) 21:24:22 INFO - PROCESS | 1944 | RSS: Main: 273739776 21:24:22 INFO - PROCESS | 1944 | 21:27:24 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51154/tests/dromaeo/cssquery-prototype.html) 21:27:24 INFO - PROCESS | 1944 | RSS: Main: 275316736 21:27:24 INFO - PROCESS | 1944 | 21:30:27 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51154/tests/dromaeo/cssquery-yui.html) 21:30:28 INFO - PROCESS | 1944 | RSS: Main: 278159360 21:30:28 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | Cycle 1(1): loaded http://localhost:51154/tests/dromaeo/cssquery-yui.html (next: http://localhost:51154/tests/dromaeo/cssquery-dojo.html) 21:33:30 INFO - PROCESS | 1944 | RSS: Main: 279257088 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | __start_tp_report 21:33:30 INFO - PROCESS | 1944 | _x_x_mozilla_page_load 21:33:30 INFO - PROCESS | 1944 | _x_x_mozilla_page_load_details 21:33:30 INFO - PROCESS | 1944 | |i|pagename|runs| 21:33:30 INFO - PROCESS | 1944 | |0;dojo.html;3450.361683088628;3464.3417750627386;3512.4380099184136;3523.57717073951;3547;5728.570357223214;5748.798792042285;5799.2750906136735;5884;5931.080682494215;4259.3610958356185;5856.5021973132225;5906.793262235823;5944.227250457435;6016.157737916695;5238.52853243208;5247.396549396811;5286.841394758144;5308.5487733542695;5335.733213339317;100.8695881488123;5225.320708307933;5263.0263401270695;5298.947010529884;5305.6551324164;4142.71001029928;5238.5023422774775;5257.789688412459;5279;5301;5242.370915490127;5285.841424757264;5294.788208471657;5297.073012222845;5319.281896943901;5140.203268493389;5214.06146893559;5292.311999440049;5307.495787900143;5315.867103322409;5722.828315150552;5736.799212027559;5751.166080918243;5761.971190144064;5784.132380143013;5608.298962629671;5857.414258574151;6100.115483254947;6174.598651087665;6177.66022868742;6178.10417489466;6182.103594978747;6210.285817130997;6220.87558248837;6328.303886572473;5144.459831717653;5815.313559067865;5886.470217680429;5948.851278718067;5992.820215393545;6171.84570385735;6263.561550691408;6270.184875966095;6273.18448601688;6278.277998030194;6123.923256659767;6131.468419844996;6172.567920245539;6189.226346706661;6203.7828675996125;6166.784162554289;6188.659623720739;6189.659568723673;6232.065190221503;6235.844103897439;6139.369480960552;6139.723712432951;6143.419763699168;6191.164192834;6200.0699895016105;6139.386061393914;6156.353582873823;6163.9383606164265;6175.475084617858;6192.287886893065;4542.409486766699;4958.107540642719;5001.024800163933;5014.147594908874;5015.498450154955;3517.067976986101;4418.80115394808;4458.264386376277;4548.840790572314;4607.562281583244;4961.231009193581;5024.924626130611;5206.219067139884;5961.850953726105;5981.983062879321;6208.627482351073;6227.595206311666;6229.53278504114;6231.906521402183;6235.345288744707;5838.562107841929;5935.910961335583;5944.464998150101;5959.672218027963;5994.610350327302;5475.151351540518;5483.506484416342;5497.532709719719;5499.7250137492965;5513.117901135799;6237.937620623918;6412.583182093149;6444.387783160592;6446.871062578816;6552.246491653521;6188.288346840171;6247.718852651551;6261.060840873905;6267.592606480564;6371.458426033839;6415.550911436155;6421.71102300407;6421.8073457796345;6429.4856411486035;6437.034444833313;6123.540734445023;6124.908126378197;6129.325774164749;6159.23009623797;6165.753369865334;6135.600157732779;6177.876442471215;6192.164057852132;6194.876102478015;6205.596636218631;6087.147799308189;6105.84735381619;6151.231096112986;6155.1382806406245;6177.660228687465;5757.309122905278;6095.634261944298;6140.969295153495;6156.322804491592;6180.165677633462;4858.368412106403;5947.226860508279;6010.669413182142;6045.667488288186;6105.297890742621;6097.75608975636;6139.631622102688;6163.876722465436;6172.629642221481;6184.690765461799;6011.699415029144;6056.121862330026;6101.237345331833;6119.204503414528;6138.357744607813 21:33:30 INFO - PROCESS | 1944 | |1;ext.html;515.0651567405162;534.4228233507812;577.5899111630742;585.0551359554319;609.18673570783;37104.81447592762;37844;37946.24107517848;37980.62019379805;38085.42871856917;32527.67472325276;39461.80269098658;39601.20797584054;39820.60179398205;40252.99367515813;8440;9491.857622135674;9769.120779129877;9780.657676981307;9798.510074496247;9566.712998610017;9685.564149613285;9687.951560242189;9726.854097188549;9752.951235243814;9714.514274286257;9729.270304727139;9735.756606084833;9781.706548803548;9846.753831154207;9714.562844671971;9775.755606109904;9779.266555008402;9799.657012004545;9809.656662016796;9646.324757266993;9676.322657413984;9732.270079744048;9736.853947190797;9804.509774511318;38126.428103578466;38422.61577384218;38686;38700.225995480214;38837.41743873844;2803.3832556837465;3054.69453054695;3128.577642018321;3356.647552007053;3387.356402283583;25313.36716582082;25466.87266563674;25524.23427297184;26805.731942680715;26843.86578067097;2631.250218604626;2641.313258552771;2721.9047333343237;2723.332783468043;2783.3737409082996;317653;325361;325769;325818.37090814393;327175.3641231802;32465.675343246738;32502.83748581242;32672;32713;32772.83613581917;34252.31495370129;34933.30133397318;35067;35212;35212.47181292283;16711.415100471426;17002.829971700372;17512.38706645261;17526.561835954202;17541.473755787345;12841.229526228457;12870.871291287154;13034.413451394521;13056.21662700241;13113.541026064042;19203.519912002033;19374.225030998885;19396.32112876071;19421.2231510738;19449.222031118596;6908.6545672716165;7290.45321600882;7937.801554961172;8118.715844945398;8190.262876341158;669.5580916595023;712.3232928717739;833.6498670558381;867.7461068755714;874.5277550122989;29285.974990875642;29601.555976660366;29730.108096757132;29800.480828810418;29889.551656725165;990.9653162139291;1080.670395529371;1115.760111576015;1142.280363371071;1154.0349085645512;13589.660258493617;13806.593911086486;14932;15070.623234419008;15181.139159610126;643940;645775;646839;651828;653222;48433.515664842904;58420;58558.707206463696;59284.40715592789;59317.70341148267;1293.6442478318538;1464.1361596658023;1469.6032071340892;1480.8963372563817;1486.6357742353193;28328.433431330846;28731.28171795722;28771.424571508873;28909.710902890703;29306;43003.784981074896;51038.489615103375;51369;52203.69490762609;52251.47748522618;575258;579189;581473;581893;581920;26414.735852641228;26643.866780665972;26665.20004399871;26817.597736034364;26876.865615671795;44304.320757066365;44910.55089449194;44982;46411.76794116008;46471.535284648075;36595.26809463849;37452.812735936146;37693;38067.23865522619;38359.04102397351;36863.81568092143;36908;37325.6267437333;37337.81331093327;37604.435933460474;36098.45852312165;36654.26691466209;36826.26347473089;37182;37401.4389784148;27967.860160699067;32651.673483265815;32798.50802238016;33006;33141;24585.508289833746;24617.876910615334;24721;24898.12856550012;25007 21:33:30 INFO - PROCESS | 1944 | |2;jquery.html;354.8616039744499;381.13292260108267;387.0362796636375;393.15079428434586;396.2847061054795;19588.90205548972;20684.48288792777;21221.57556848864;21248.787512124873;21279.361619151412;19491.317803876867;20136;20235.291764788235;20720.585588288264;20863.47841303968;5600.467955544217;5870.3542610312725;5924.703764811764;5935.49548288396;6068.271807383098;4973.278874563186;5932.11018347247;5966.37353077927;5987.970060149715;6001.039833626621;5231.633785635007;5847.26909136358;5899.498542623882;5906;5915.852103697399;5703.458171473703;5811.82564523065;5876.764929402819;5890.028145356033;5922.022866227067;4985.52637499437;5055.721935293557;5066.518680725325;5116.104681680691;5175.637705360627;25259.368515787253;25406.856691448927;25480;25498;26351.68241587932;1808.1953530678852;2119.109973811003;2127.106615221611;2179.466030822443;2756.986215068932;14613.70772584553;14688.853111468856;14889.255537223204;15031.173285469295;15147.772783408147;1681.697294486992;1723.4829551134735;1757.165346460421;1760.4014635024025;1772.53027947594;101801.49099254457;101839.92640294453;102012;102303;103330.99999999924;9239.584218710173;11144.60993865211;11380.772384552429;11461.828072578752;11589.594364197214;14019;14209.78685319721;14217.715645687234;14231.573052808433;14232.21722805235;8742.956285218661;8857.424267422726;8916.777080572907;8921.821563568692;8952.373333866697;8970.730878073538;8981.685641002534;8992.46045237288;8998.415103018282;9016.639334426549;6738.719643267764;6822.351876571718;6855.931440685629;6870.828229294308;6891.104156459728;1855.7123645834918;1860.5441666791723;1873.5128866494538;1901.9334323298617;1940.1560321260297;897.3852910756153;949.292776881228;981.5141504955093;986.3785814936545;996.8355221388534;20742.688859667116;21454.678179827315;21470.78529214719;21537.461563460725;21632.459188520414;811.9837603247902;907.2197909797569;951.8952915179325;976.1556253840519;1036.1555332404066;11119.166062545342;11543.134264929995;11569.479373428216;11572.132090093277;11585.015273701661;505918;591170;614239;615062;617034;78593.60703196448;102442.36566988887;111901.88098119077;146492;147803;888.600129941516;982.4400091947522;990.4008075114452;991.1624677147798;1008.4201584089031;18504.537386565444;18675.066246687882;18720;18767.530811729815;18825.529361766065;55170;55328.89342213214;55664.72167639136;56328.71835640795;56774.729010840754;79754;80051.79922301287;80511.19488805038;82407;82607.93480163044;5455.236266922555;5731.799387021434;7964.522128672298;8073.475224110414;8138.145494722969;10955.56177752881;11880.405979701154;12206.145569810027;12631.93684031574;12840.357982100672;10723.410212438392;10887.455627218766;10891.237613367306;10989.945050274697;11083.390413527333;10673.199510036933;10678.359298442118;10712.14302855754;10891.727706807393;10950.945245273722;11090.170121929792;11405.144614154138;11517.02105321057;11538.769224615293;11646;6143.508519318533;7336.853262934818;7811.672015757448;8041.798955026171;8075.394345424234;10168.491575421347;10847.40339281347;10918.617848375268;11182.88817111851;11191.832122518332 21:33:30 INFO - PROCESS | 1944 | |3;mootools.html;1570.8115026196858;1643.515163026907;1829.277435413011;1897.487678326851;1915.789263181049;8073;8661.350398720098;8684.392092553524;8936.061713520076;8944.463332200072;8636.870446943285;8698.695545655903;8753.781155471117;8766.649334026648;8794.252488538483;1977.6736838421643;2132.7867213278705;2241.047554789216;2439.548683493555;2452.6443665668467;2103.3479621317365;2419.4072452249225;2420.177139772477;2430.562498750224;2447.3881529617597;2416.347586151738;2434.85390876548;2443.4746529496156;2449.1183174057323;2449.301948944551;2195.2536137713255;2273.011240110557;2417.443987882788;2427.4416884116663;2428.720697119836;2357.610994185957;2390.09176512924;2397.113068164773;2416.371743346725;2425.854448733082;8719.084496127878;8827.602757875848;8921.241694455914;8925.776855578597;8943.060978597283;5247.816326428557;5323.733813309358;5418.4039755626845;5425.240466334716;5453.481919217668;3510.2102027043966;3530.858765649371;3549.343371476285;3573.8391772370305;3576.856925722968;998.9100980911753;1015.0509273828993;1016.7051555049027;1024.211357254917;1029.696239609317;11369.374684392355;11537.192396532246;11539.826902596384;11584.362860042695;11587.942060289728;4223.619874211336;4656.883577910579;4678.391809064799;4894.755262236874;4914.852554423373;9823.312368134304;9827.066428689262;9840.458774767314;9847.212223022141;9866.80266394668;5362.142057270896;5384.273123128406;5399.4600539945695;5435.809746658848;5436.374816896028;4320.546342634041;4343.609075183249;4882.072406242803;4931.112399768076;4937.11131996237;4052.4124002019544;4079.653229475528;4082.3060079786505;4181.184668989578;4209.6000879916355;1344.327836081959;1356.2066191278213;1357.5406438079106;1361.4418088583634;1368.3090039529973;816.6447595296065;878.4509681449094;911.4667919267303;933.4166146158651;942.6512190489562;5790.160426738184;5933.851653708692;5938.435848594377;6037.698115094227;6222.439980401786;436.9628581570602;457.3756821938031;470.6940488682384;474.65587449099814;475.1020571120585;3607.9098022549647;3884.0678237222864;3950.4074388841905;4030.455888455021;4033.616806403387;10450.372977621368;11000.724981875517;11003.394813285186;11070.169737269576;11094.778104438028;10731.2488125832;10827.24209305341;10874.945625271981;10943.507542160622;11020.50407731654;8086.474379165335;8148.796280092926;8181.140980196994;8285.461445006176;8319.958400208081;5477.3427188737605;5893.410658934073;5976.731047102978;5990.940090599038;6048.12302216185;9956.904740478396;9990.200783937413;10013.2490063247;10146.644867429604;10184.847227291448;9372.625094996123;9831.705048848546;10053.49732513386;10311.123554497952;10390.428526431118;6312.5265605078885;6914.0666010088;7359.300866417681;7520.360769334668;7674.309312161932;8038.598070096355;8205.876911846208;8310.70912518059;8322.292605128632;8366.748997530083;7238.348548630648;7300.598467084362;7361.926380736339;7433.628318584158;7518.924810751822;7248.483032436971;7346.6693998769115;7422.777316680508;7423.035005449257;7457.850842983218;5459.344878614433;6131.509479241739;6617.569857959217;6978.79063628092;7024.824379390556;4791.113643975876;4909.189983652657;4940.456549779593;5036.697798132123;5156.716380598953;4959.231319145538;4987.875303117451;5054.949450505448;5115.667481613832;5317.654352467077 21:33:30 INFO - PROCESS | 1944 | |4;prototype.html;282.20981252493016;287.1801008121812;303.02879271933455;307.166044190024;307.2671678047855;5183.688978661283;5207.531322181003;5500.944990550103;5668.716564171796;6236.220472440945;6173.567850250484;6221.564490485668;6229.190205273319;6242.781502647408;6257.124002639634;4534.9546504534865;4561.156186105564;4583.19794036044;4584.19776539106;4625.213713668684;3458.4120699481023;3665.8350374233223;4391.538888416718;4467.17357288901;4553.453585569736;4431.689781715281;4434.467863856342;4438.356438316442;4440.53638162234;4462.995825939171;4466.553344665524;4478.440194975628;4484.529124441952;4485.170243504962;4532.592066714012;3677.7793332400142;3764.8305826237884;3771.7171212159196;3802.657760801541;3807.067268519203;4520.073384956077;5373.489518495737;5550.139728342114;5880.4119588041285;5914.349421563625;4435.733855968652;4478.149151661174;5184.7148406837605;5196.155364845463;5252;6208.441240288351;6566.8508011097865;6589.604623722592;6596.373344532261;6683.5655682380975;3777.244551089793;4036.2936486115104;4186.6859985500905;4222.493300803892;4273.4444522212225;6833.5216534843075;6937.791866244021;6953.443724502028;7023.051887995158;7027.613481258529;3757.380032294641;4175.97912010438;4251.829926802955;4254.361845723166;4268.701190916669;4279.229738647074;4327.874752564356;4337.587929146726;4340.6110044786;4346.782660866944;5159;5159.896802063938;5175.534201921845;5181.171012637959;5181.2746215529105;5574.58190635704;5683.943160568424;6318.810435686937;6338.239411270677;6514.599361137378;1462.656275775192;1462.7201198950918;1480.7630779075296;1481.140938255809;1513.3038802150913;800.1838125112353;918.5177781664679;937.2174234514121;938.4556956964944;960.5869476125333;5188.92216616751;5210.400803907523;6128;6152.8769424611255;6166.660833654192;5803.7388317524965;6872;6892;6893.862122757617;6918.308169183041;5848.385919478478;6169.444749972435;6224.253089629183;6267.905981410283;6284.811455656338;3624.4382120771324;3643.544556930384;3671.8714844980295;3673.4306182541213;3695.2978934002454;5816.709164541756;6015.939840601625;7198.424126069902;7251.601161936144;7274.30894065063;7008;7147.9285207148305;7169.6773645186095;7180.748673796392;7235.803234124195;6029.78895738647;6712.328767123347;6866.656667166621;7221.386182174574;7238.565686058853;6814.625195614289;6890.44876409876;6968.895466568107;6970.546914450544;6984.755533556301;5868.589198756046;6439.7424103035355;6808;6812.012258222431;6963.79108626742;6155.630662160105;7242.094738157731;7356;7422.294881986203;7425.628718564159;4008.779517126586;4305.48334199898;4310.612044915973;4323.956760432356;4346.500152482505;5955.880882382241;6577.6053436793945;6736.461083113437;6966.407855332353;6974.651267436507;5755.971220143872;6706.195256569243;6749.392554670103;6766.729330826712;6813.012113243651;6028.457438830526;6512.153420055552;6683.930571108599;6745.662716864039;6749.628770417674;5931.602241959796;6155.876882462236;6420.1974753155855;6524.119243902012;6574.967125164535;5700.771969121354;6713.530052896251;6760.459163266829;6780.762673306411;6833.248342682202;6291.496680265476;6376.840578985562;6538.542302038812;6558.80323590293;6618.966905165444 21:33:30 INFO - PROCESS | 1944 | |5;yui.html;650.4731167754118;658.9835254118647;741.788590251778;745.4260219630881;764.8049747314437;14804.037737547053;14952.476663316786;15156.24218789059;15270.694586108271;15351.462698805544;13924.721505569882;13955.372008259626;13963.232022238773;13966.30168491574;14047.016708830386;709.7657772934945;763.7097902796929;878.547548012774;898.7034278688018;900.7658008917696;809.0453265147124;894.472261365794;897.2507955856835;897.443584977315;901.4591245252828;738.401894465482;822.6503735912213;846.5132548784443;904.5612877754284;972.951352432379;945.5225111318808;957.0764212534938;957.1051067252141;964.7202311329706;965.8454647256441;708.8582283543312;712.3304094151481;717.3866344275622;720.7009091227135;725.4124159430878;12365.31990740509;14332.140071595633;14709.11745295275;14716.264186790617;14760.335784889598;12814.038947078912;12819.615411537576;12945.87054129456;13226.272555009567;13315.134516256509;10072.899271007269;10087.142592879614;10139.188864890792;10372.63695770652;10484.318519296221;3497.422925217336;3503.1592417819793;3521.0845180253064;3546;3573.749837511375;58355.41644583542;64435;77775.61112194459;81072.59463702644;81766.59116704437;9293.90706092944;9491.525423728786;9492.050794920453;9651.227901767841;9683.370580912218;21907.26159230096;21969.340919772432;22063;22614.869256537437;22639.886800566223;6336.52476064297;7405.306423040998;7424.220456852061;7703.460757746904;7704.26809453101;3991.1419044905483;4048.0689441428635;4085.571015043437;4092.8567500137947;4101.610347017028;3475.461303497962;3522.735794815399;3527.4885141654318;3559.60844307126;3595.065283026432;567.4750855458684;633.7148283272546;650.8828410886086;660.7489154121499;664.2925284571916;485.965982381237;514.6466866532649;518.9931532826305;559.1640497456328;572.6678526454647;7907.723229686933;7985.5208687478935;8002.439829211899;8163.959180204061;8219.178082191853;559.9836297120794;577.7717801468397;583.9562032847554;589.4753669234385;590.2061726977208;3721.6650501454455;3867.651911327994;3899.239648268617;3908.4332771747936;3923.097687531884;78815;92679;94954;95225;95447.52276238575;50607.74696126496;67610.30974225585;68616.31383686198;71399.92900106503;72679;53859;61807.145785626504;62478;63173.05240421397;63814.36185638177;7998.320142787696;8017.518948863087;8143.900573422512;8145.348372130097;8325.916740832514;40747;42137;43975;44051.77974110109;44394;64510;65501.344986551434;65789.67105164635;65928.3517912056;66378.66810665916;10389.792204156025;10644.467776610983;10668.359898406121;10743.08683761889;10993.835092473779;11848.933595976403;11855.881441185478;12226.633201003984;12236.816447753468;12459;10784.299020563638;11701.707457313294;11702.063834893359;11839.76320473603;12158.148929574845;10620.15038796879;11272;11306.94346528262;11468.19722619442;12206.6948326289;11080.39057851826;11101.333919964827;11130.666080017612;11167.609133680282;11239.438028098399;9395.671151509665;9441.055894410503;9501.382410143595;9637.662681806103;9788.657396991071;9285.72142835716;9528.142467177988;9568.712938611852;9601.855972160563;9638.662646807608 21:33:30 INFO - PROCESS | 1944 | __end_tp_report 21:33:30 INFO - PROCESS | 1944 | __start_cc_report 21:33:30 INFO - PROCESS | 1944 | _x_x_mozilla_cycle_collect,391 21:33:30 INFO - PROCESS | 1944 | __end_cc_report 21:33:30 INFO - PROCESS | 1944 | __startTimestamp1461299610784__endTimestamp 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | ------- Summary: start ------- 21:33:30 INFO - PROCESS | 1944 | Number of tests: 6 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#0] dojo.html Cycles:165 Average:5716.63 Median:6045.67 stddev:796.05 (13.2%) stddev-sans-first:778.39 21:33:30 INFO - PROCESS | 1944 | Values: 3450.4 3464.3 3512.4 3523.6 3547.0 5728.6 5748.8 5799.3 5884.0 5931.1 4259.4 5856.5 5906.8 5944.2 6016.2 5238.5 5247.4 5286.8 5308.5 5335.7 100.9 5225.3 5263.0 5298.9 5305.7 4142.7 5238.5 5257.8 5279.0 5301.0 5242.4 5285.8 5294.8 5297.1 5319.3 5140.2 5214.1 5292.3 5307.5 5315.9 5722.8 5736.8 5751.2 5762.0 5784.1 5608.3 5857.4 6100.1 6174.6 6177.7 6178.1 6182.1 6210.3 6220.9 6328.3 5144.5 5815.3 5886.5 5948.9 5992.8 6171.8 6263.6 6270.2 6273.2 6278.3 6123.9 6131.5 6172.6 6189.2 6203.8 6166.8 6188.7 6189.7 6232.1 6235.8 6139.4 6139.7 6143.4 6191.2 6200.1 6139.4 6156.4 6163.9 6175.5 6192.3 4542.4 4958.1 5001.0 5014.1 5015.5 3517.1 4418.8 4458.3 4548.8 4607.6 4961.2 5024.9 5206.2 5961.9 5982.0 6208.6 6227.6 6229.5 6231.9 6235.3 5838.6 5935.9 5944.5 5959.7 5994.6 5475.2 5483.5 5497.5 5499.7 5513.1 6237.9 6412.6 6444.4 6446.9 6552.2 6188.3 6247.7 6261.1 6267.6 6371.5 6415.6 6421.7 6421.8 6429.5 6437.0 6123.5 6124.9 6129.3 6159.2 6165.8 6135.6 6177.9 6192.2 6194.9 6205.6 6087.1 6105.8 6151.2 6155.1 6177.7 5757.3 6095.6 6141.0 6156.3 6180.2 4858.4 5947.2 6010.7 6045.7 6105.3 6097.8 6139.6 6163.9 6172.6 6184.7 6011.7 6056.1 6101.2 6119.2 6138.4 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#1] ext.html Cycles:180 Average:63791.79 Median:37006.41 stddev:143809.55 (388.6%) stddev-sans-first:144134.50 21:33:30 INFO - PROCESS | 1944 | Values: 515.1 534.4 577.6 585.1 609.2 37104.8 37844.0 37946.2 37980.6 38085.4 32527.7 39461.8 39601.2 39820.6 40253.0 8440.0 9491.9 9769.1 9780.7 9798.5 9566.7 9685.6 9688.0 9726.9 9753.0 9714.5 9729.3 9735.8 9781.7 9846.8 9714.6 9775.8 9779.3 9799.7 9809.7 9646.3 9676.3 9732.3 9736.9 9804.5 38126.4 38422.6 38686.0 38700.2 38837.4 2803.4 3054.7 3128.6 3356.6 3387.4 25313.4 25466.9 25524.2 26805.7 26843.9 2631.3 2641.3 2721.9 2723.3 2783.4 317653.0 325361.0 325769.0 325818.4 327175.4 32465.7 32502.8 32672.0 32713.0 32772.8 34252.3 34933.3 35067.0 35212.0 35212.5 16711.4 17002.8 17512.4 17526.6 17541.5 12841.2 12870.9 13034.4 13056.2 13113.5 19203.5 19374.2 19396.3 19421.2 19449.2 6908.7 7290.5 7937.8 8118.7 8190.3 669.6 712.3 833.6 867.7 874.5 29286.0 29601.6 29730.1 29800.5 29889.6 991.0 1080.7 1115.8 1142.3 1154.0 13589.7 13806.6 14932.0 15070.6 15181.1 643940.0 645775.0 646839.0 651828.0 653222.0 48433.5 58420.0 58558.7 59284.4 59317.7 1293.6 1464.1 1469.6 1480.9 1486.6 28328.4 28731.3 28771.4 28909.7 29306.0 43003.8 51038.5 51369.0 52203.7 52251.5 575258.0 579189.0 581473.0 581893.0 581920.0 26414.7 26643.9 26665.2 26817.6 26876.9 44304.3 44910.6 44982.0 46411.8 46471.5 36595.3 37452.8 37693.0 38067.2 38359.0 36863.8 36908.0 37325.6 37337.8 37604.4 36098.5 36654.3 36826.3 37182.0 37401.4 27967.9 32651.7 32798.5 33006.0 33141.0 24585.5 24617.9 24721.0 24898.1 25007.0 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#2] jquery.html Cycles:180 Average:34342.67 Median:25443.43 stddev:98117.14 (385.6%) stddev-sans-first:98359.20 21:33:30 INFO - PROCESS | 1944 | Values: 354.9 381.1 387.0 393.2 396.3 19588.9 20684.5 21221.6 21248.8 21279.4 19491.3 20136.0 20235.3 20720.6 20863.5 5600.5 5870.4 5924.7 5935.5 6068.3 4973.3 5932.1 5966.4 5988.0 6001.0 5231.6 5847.3 5899.5 5906.0 5915.9 5703.5 5811.8 5876.8 5890.0 5922.0 4985.5 5055.7 5066.5 5116.1 5175.6 25259.4 25406.9 25480.0 25498.0 26351.7 1808.2 2119.1 2127.1 2179.5 2757.0 14613.7 14688.9 14889.3 15031.2 15147.8 1681.7 1723.5 1757.2 1760.4 1772.5 101801.5 101839.9 102012.0 102303.0 103331.0 9239.6 11144.6 11380.8 11461.8 11589.6 14019.0 14209.8 14217.7 14231.6 14232.2 8743.0 8857.4 8916.8 8921.8 8952.4 8970.7 8981.7 8992.5 8998.4 9016.6 6738.7 6822.4 6855.9 6870.8 6891.1 1855.7 1860.5 1873.5 1901.9 1940.2 897.4 949.3 981.5 986.4 996.8 20742.7 21454.7 21470.8 21537.5 21632.5 812.0 907.2 951.9 976.2 1036.2 11119.2 11543.1 11569.5 11572.1 11585.0 505918.0 591170.0 614239.0 615062.0 617034.0 78593.6 102442.4 111901.9 146492.0 147803.0 888.6 982.4 990.4 991.2 1008.4 18504.5 18675.1 18720.0 18767.5 18825.5 55170.0 55328.9 55664.7 56328.7 56774.7 79754.0 80051.8 80511.2 82407.0 82607.9 5455.2 5731.8 7964.5 8073.5 8138.1 10955.6 11880.4 12206.1 12631.9 12840.4 10723.4 10887.5 10891.2 10989.9 11083.4 10673.2 10678.4 10712.1 10891.7 10950.9 11090.2 11405.1 11517.0 11538.8 11646.0 6143.5 7336.9 7811.7 8041.8 8075.4 10168.5 10847.4 10918.6 11182.9 11191.8 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#3] mootools.html Cycles:180 Average:5700.02 Median:4934.11 stddev:3211.07 (65.1%) stddev-sans-first:3205.09 21:33:30 INFO - PROCESS | 1944 | Values: 1570.8 1643.5 1829.3 1897.5 1915.8 8073.0 8661.4 8684.4 8936.1 8944.5 8636.9 8698.7 8753.8 8766.6 8794.3 1977.7 2132.8 2241.0 2439.5 2452.6 2103.3 2419.4 2420.2 2430.6 2447.4 2416.3 2434.9 2443.5 2449.1 2449.3 2195.3 2273.0 2417.4 2427.4 2428.7 2357.6 2390.1 2397.1 2416.4 2425.9 8719.1 8827.6 8921.2 8925.8 8943.1 5247.8 5323.7 5418.4 5425.2 5453.5 3510.2 3530.9 3549.3 3573.8 3576.9 998.9 1015.1 1016.7 1024.2 1029.7 11369.4 11537.2 11539.8 11584.4 11587.9 4223.6 4656.9 4678.4 4894.8 4914.9 9823.3 9827.1 9840.5 9847.2 9866.8 5362.1 5384.3 5399.5 5435.8 5436.4 4320.5 4343.6 4882.1 4931.1 4937.1 4052.4 4079.7 4082.3 4181.2 4209.6 1344.3 1356.2 1357.5 1361.4 1368.3 816.6 878.5 911.5 933.4 942.7 5790.2 5933.9 5938.4 6037.7 6222.4 437.0 457.4 470.7 474.7 475.1 3607.9 3884.1 3950.4 4030.5 4033.6 10450.4 11000.7 11003.4 11070.2 11094.8 10731.2 10827.2 10874.9 10943.5 11020.5 8086.5 8148.8 8181.1 8285.5 8320.0 5477.3 5893.4 5976.7 5990.9 6048.1 9956.9 9990.2 10013.2 10146.6 10184.8 9372.6 9831.7 10053.5 10311.1 10390.4 6312.5 6914.1 7359.3 7520.4 7674.3 8038.6 8205.9 8310.7 8322.3 8366.7 7238.3 7300.6 7361.9 7433.6 7518.9 7248.5 7346.7 7422.8 7423.0 7457.9 5459.3 6131.5 6617.6 6978.8 7024.8 4791.1 4909.2 4940.5 5036.7 5156.7 4959.2 4987.9 5054.9 5115.7 5317.7 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#4] prototype.html Cycles:180 Average:5290.09 Median:5985.91 stddev:1738.88 (29.0%) stddev-sans-first:1702.65 21:33:30 INFO - PROCESS | 1944 | Values: 282.2 287.2 303.0 307.2 307.3 5183.7 5207.5 5500.9 5668.7 6236.2 6173.6 6221.6 6229.2 6242.8 6257.1 4535.0 4561.2 4583.2 4584.2 4625.2 3458.4 3665.8 4391.5 4467.2 4553.5 4431.7 4434.5 4438.4 4440.5 4463.0 4466.6 4478.4 4484.5 4485.2 4532.6 3677.8 3764.8 3771.7 3802.7 3807.1 4520.1 5373.5 5550.1 5880.4 5914.3 4435.7 4478.1 5184.7 5196.2 5252.0 6208.4 6566.9 6589.6 6596.4 6683.6 3777.2 4036.3 4186.7 4222.5 4273.4 6833.5 6937.8 6953.4 7023.1 7027.6 3757.4 4176.0 4251.8 4254.4 4268.7 4279.2 4327.9 4337.6 4340.6 4346.8 5159.0 5159.9 5175.5 5181.2 5181.3 5574.6 5683.9 6318.8 6338.2 6514.6 1462.7 1462.7 1480.8 1481.1 1513.3 800.2 918.5 937.2 938.5 960.6 5188.9 5210.4 6128.0 6152.9 6166.7 5803.7 6872.0 6892.0 6893.9 6918.3 5848.4 6169.4 6224.3 6267.9 6284.8 3624.4 3643.5 3671.9 3673.4 3695.3 5816.7 6015.9 7198.4 7251.6 7274.3 7008.0 7147.9 7169.7 7180.7 7235.8 6029.8 6712.3 6866.7 7221.4 7238.6 6814.6 6890.4 6968.9 6970.5 6984.8 5868.6 6439.7 6808.0 6812.0 6963.8 6155.6 7242.1 7356.0 7422.3 7425.6 4008.8 4305.5 4310.6 4324.0 4346.5 5955.9 6577.6 6736.5 6966.4 6974.7 5756.0 6706.2 6749.4 6766.7 6813.0 6028.5 6512.2 6683.9 6745.7 6749.6 5931.6 6155.9 6420.2 6524.1 6575.0 5700.8 6713.5 6760.5 6780.8 6833.2 6291.5 6376.8 6538.5 6558.8 6619.0 21:33:30 INFO - PROCESS | 1944 | 21:33:30 INFO - PROCESS | 1944 | [#5] yui.html Cycles:180 Average:17208.46 Median:29469.69 stddev:23647.75 (80.2%) stddev-sans-first:23681.40 21:33:30 INFO - PROCESS | 1944 | Values: 650.5 659.0 741.8 745.4 764.8 14804.0 14952.5 15156.2 15270.7 15351.5 13924.7 13955.4 13963.2 13966.3 14047.0 709.8 763.7 878.5 898.7 900.8 809.0 894.5 897.3 897.4 901.5 738.4 822.7 846.5 904.6 973.0 945.5 957.1 957.1 964.7 965.8 708.9 712.3 717.4 720.7 725.4 12365.3 14332.1 14709.1 14716.3 14760.3 12814.0 12819.6 12945.9 13226.3 13315.1 10072.9 10087.1 10139.2 10372.6 10484.3 3497.4 3503.2 3521.1 3546.0 3573.7 58355.4 64435.0 77775.6 81072.6 81766.6 9293.9 9491.5 9492.1 9651.2 9683.4 21907.3 21969.3 22063.0 22614.9 22639.9 6336.5 7405.3 7424.2 7703.5 7704.3 3991.1 4048.1 4085.6 4092.9 4101.6 3475.5 3522.7 3527.5 3559.6 3595.1 567.5 633.7 650.9 660.7 664.3 486.0 514.6 519.0 559.2 572.7 7907.7 7985.5 8002.4 8164.0 8219.2 560.0 577.8 584.0 589.5 590.2 3721.7 3867.7 3899.2 3908.4 3923.1 78815.0 92679.0 94954.0 95225.0 95447.5 50607.7 67610.3 68616.3 71399.9 72679.0 53859.0 61807.1 62478.0 63173.1 63814.4 7998.3 8017.5 8143.9 8145.3 8325.9 40747.0 42137.0 43975.0 44051.8 44394.0 64510.0 65501.3 65789.7 65928.4 66378.7 10389.8 10644.5 10668.4 10743.1 10993.8 11848.9 11855.9 12226.6 12236.8 12459.0 10784.3 11701.7 11702.1 11839.8 12158.1 10620.2 11272.0 11306.9 11468.2 12206.7 11080.4 11101.3 11130.7 11167.6 11239.4 9395.7 9441.1 9501.4 9637.7 9788.7 9285.7 9528.1 9568.7 9601.9 9638.7 21:33:30 INFO - PROCESS | 1944 | -------- Summary: end -------- 21:33:30 INFO - PROCESS | 1944 | 21:33:31 INFO - TEST-INFO | 1944: exit 0 21:33:31 INFO - TEST-OK | dromaeo_css | took 1111542ms 21:33:31 INFO - TEST-START | kraken 21:33:31 INFO - operating with platform_type : mac_ 21:33:31 INFO - Initialising browser for kraken test... 21:33:31 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpcNq2yB/profile http://localhost:51154/getInfo.html) 21:33:34 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 21:33:34 INFO - PROCESS | 1949 | colorDepth:24 21:33:34 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 21:33:34 INFO - PROCESS | 1949 | __metrics 21:33:34 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 21:33:34 INFO - TEST-INFO | 1949: exit 0 21:33:34 INFO - Browser initialized. 21:33:34 INFO - Running cycle 1/1 for kraken test... 21:33:34 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/tmpcNq2yB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:33:47 INFO - PROCESS | 1952 | RSS: Main: 247996416 21:33:47 INFO - PROCESS | 1952 | 21:33:49 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51154/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:50 INFO - PROCESS | 1952 | RSS: Main: 260165632 21:33:50 INFO - PROCESS | 1952 | 21:33:53 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51154/tests/kraken/driver.html?testName=audio-dft) 21:33:54 INFO - PROCESS | 1952 | RSS: Main: 268996608 21:33:54 INFO - PROCESS | 1952 | 21:33:57 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51154/tests/kraken/driver.html?testName=audio-fft) 21:33:58 INFO - PROCESS | 1952 | RSS: Main: 272142336 21:33:58 INFO - PROCESS | 1952 | 21:34:00 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51154/tests/kraken/driver.html?testName=audio-oscillator) 21:34:00 INFO - PROCESS | 1952 | RSS: Main: 273108992 21:34:00 INFO - PROCESS | 1952 | 21:34:03 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:34:03 INFO - PROCESS | 1952 | RSS: Main: 273559552 21:34:03 INFO - PROCESS | 1952 | 21:34:06 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51154/tests/kraken/driver.html?testName=imaging-darkroom) 21:34:07 INFO - PROCESS | 1952 | RSS: Main: 274677760 21:34:07 INFO - PROCESS | 1952 | 21:34:10 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51154/tests/kraken/driver.html?testName=imaging-desaturate) 21:34:10 INFO - PROCESS | 1952 | RSS: Main: 274857984 21:34:10 INFO - PROCESS | 1952 | 21:34:13 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51154/tests/kraken/driver.html?testName=json-parse-financial) 21:34:14 INFO - PROCESS | 1952 | RSS: Main: 275226624 21:34:14 INFO - PROCESS | 1952 | 21:34:15 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:34:16 INFO - PROCESS | 1952 | RSS: Main: 274874368 21:34:16 INFO - PROCESS | 1952 | 21:34:18 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:34:19 INFO - PROCESS | 1952 | RSS: Main: 275058688 21:34:19 INFO - PROCESS | 1952 | 21:34:21 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:22 INFO - PROCESS | 1952 | RSS: Main: 275361792 21:34:22 INFO - PROCESS | 1952 | 21:34:24 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:25 INFO - PROCESS | 1952 | RSS: Main: 275394560 21:34:25 INFO - PROCESS | 1952 | 21:34:28 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:29 INFO - PROCESS | 1952 | RSS: Main: 275324928 21:34:29 INFO - PROCESS | 1952 | 21:34:30 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:51154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51154/tests/kraken/driver.html?testName=ai-astar) 21:34:31 INFO - PROCESS | 1952 | RSS: Main: 277196800 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | __start_tp_report 21:34:31 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 21:34:31 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 21:34:31 INFO - PROCESS | 1952 | |i|pagename|runs| 21:34:31 INFO - PROCESS | 1952 | |0;ai-astar;116;111;119;117;119;130;117;155;171;117 21:34:31 INFO - PROCESS | 1952 | |1;audio-beat-detection;182;120;147;163;123;137;141;141;163;146 21:34:31 INFO - PROCESS | 1952 | |2;audio-dft;194;206;216;234;252;203;195;201;201;264 21:34:31 INFO - PROCESS | 1952 | |3;audio-fft;66;82;74;135;76;81;86;54;66;62 21:34:31 INFO - PROCESS | 1952 | |4;audio-oscillator;81;115;167;106;83;84;124;109;113;146 21:34:31 INFO - PROCESS | 1952 | |5;imaging-gaussian-blur;91;87;98;112;90;79;131;88;90;87 21:34:31 INFO - PROCESS | 1952 | |6;imaging-darkroom;94;97;96;96;95;101;96;98;95;95 21:34:31 INFO - PROCESS | 1952 | |7;imaging-desaturate;96;97;96;91;95;94;93;94;122;128 21:34:31 INFO - PROCESS | 1952 | |8;json-parse-financial;62;64;61;60;61;57;64;79;66;61 21:34:31 INFO - PROCESS | 1952 | |9;json-stringify-tinderbox;64;66;73;73;77;74;68;93;97;92 21:34:31 INFO - PROCESS | 1952 | |10;stanford-crypto-aes;84;99;107;105;100;86;84;83;83;83 21:34:31 INFO - PROCESS | 1952 | |11;stanford-crypto-ccm;143;151;159;156;158;157;149;139;203;175 21:34:31 INFO - PROCESS | 1952 | |12;stanford-crypto-pbkdf2;173;174;172;173;175;171;175;174;176;178 21:34:31 INFO - PROCESS | 1952 | |13;stanford-crypto-sha256-iterative;73;72;68;69;74;70;68;87;86;71 21:34:31 INFO - PROCESS | 1952 | __end_tp_report 21:34:31 INFO - PROCESS | 1952 | __start_cc_report 21:34:31 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1022 21:34:31 INFO - PROCESS | 1952 | __end_cc_report 21:34:31 INFO - PROCESS | 1952 | __startTimestamp1461299671142__endTimestamp 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | ------- Summary: start ------- 21:34:31 INFO - PROCESS | 1952 | Number of tests: 14 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#0] ai-astar Cycles:10 Average:127.20 Median:119.00 stddev:19.81 (16.7%) stddev-sans-first:20.60 21:34:31 INFO - PROCESS | 1952 | Values: 116.0 111.0 119.0 117.0 119.0 130.0 117.0 155.0 171.0 117.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:146.50 stddev:18.89 (12.9%) stddev-sans-first:14.97 21:34:31 INFO - PROCESS | 1952 | Values: 182.0 120.0 147.0 163.0 123.0 137.0 141.0 141.0 163.0 146.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#2] audio-dft Cycles:10 Average:216.60 Median:211.00 stddev:24.86 (11.8%) stddev-sans-first:24.99 21:34:31 INFO - PROCESS | 1952 | Values: 194.0 206.0 216.0 234.0 252.0 203.0 195.0 201.0 201.0 264.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#3] audio-fft Cycles:10 Average:78.20 Median:75.00 stddev:22.30 (29.7%) stddev-sans-first:23.22 21:34:31 INFO - PROCESS | 1952 | Values: 66.0 82.0 74.0 135.0 76.0 81.0 86.0 54.0 66.0 62.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#4] audio-oscillator Cycles:10 Average:112.80 Median:156.50 stddev:27.81 (17.8%) stddev-sans-first:27.01 21:34:31 INFO - PROCESS | 1952 | Values: 81.0 115.0 167.0 106.0 83.0 84.0 124.0 109.0 113.0 146.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:89.00 stddev:15.25 (17.1%) stddev-sans-first:16.09 21:34:31 INFO - PROCESS | 1952 | Values: 91.0 87.0 98.0 112.0 90.0 79.0 131.0 88.0 90.0 87.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:2.00 (2.1%) stddev-sans-first:1.94 21:34:31 INFO - PROCESS | 1952 | Values: 94.0 97.0 96.0 96.0 95.0 101.0 96.0 98.0 95.0 95.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#7] imaging-desaturate Cycles:10 Average:100.60 Median:94.50 stddev:13.05 (13.8%) stddev-sans-first:13.73 21:34:31 INFO - PROCESS | 1952 | Values: 96.0 97.0 96.0 91.0 95.0 94.0 93.0 94.0 122.0 128.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.00 stddev:5.99 (9.5%) stddev-sans-first:6.32 21:34:31 INFO - PROCESS | 1952 | Values: 62.0 64.0 61.0 60.0 61.0 57.0 64.0 79.0 66.0 61.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:75.50 stddev:11.96 (15.8%) stddev-sans-first:11.62 21:34:31 INFO - PROCESS | 1952 | Values: 64.0 66.0 73.0 73.0 77.0 74.0 68.0 93.0 97.0 92.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:83.50 stddev:10.06 (12.0%) stddev-sans-first:10.31 21:34:31 INFO - PROCESS | 1952 | Values: 84.0 99.0 107.0 105.0 100.0 86.0 84.0 83.0 83.0 83.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:157.50 stddev:18.34 (11.6%) stddev-sans-first:18.51 21:34:31 INFO - PROCESS | 1952 | Values: 143.0 151.0 159.0 156.0 158.0 157.0 149.0 139.0 203.0 175.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:174.50 stddev:2.02 (1.2%) stddev-sans-first:2.11 21:34:31 INFO - PROCESS | 1952 | Values: 173.0 174.0 172.0 173.0 175.0 171.0 175.0 174.0 176.0 178.0 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - PROCESS | 1952 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:72.50 stddev:6.99 (9.6%) stddev-sans-first:7.41 21:34:31 INFO - PROCESS | 1952 | Values: 73.0 72.0 68.0 69.0 74.0 70.0 68.0 87.0 86.0 71.0 21:34:31 INFO - PROCESS | 1952 | -------- Summary: end -------- 21:34:31 INFO - PROCESS | 1952 | 21:34:31 INFO - TEST-INFO | 1952: exit 0 21:34:31 INFO - TEST-OK | kraken | took 60568ms 21:34:31 INFO - SUITE-END | took 1172s 21:34:32 INFO - Completed test suite (00:19:32) 21:34:32 INFO - javascript benchmark 21:34:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3450.361683088628, 3464.3417750627386, 3512.4380099184136, 3523.57717073951, 3547.0, 5728.570357223214, 5748.798792042285, 5799.2750906136735, 5884.0, 5931.080682494215, 4259.3610958356185, 5856.5021973132225, 5906.793262235823, 5944.227250457435, 6016.157737916695, 5238.52853243208, 5247.396549396811, 5286.841394758144, 5308.5487733542695, 5335.733213339317, 100.8695881488123, 5225.320708307933, 5263.0263401270695, 5298.947010529884, 5305.6551324164, 4142.71001029928, 5238.5023422774775, 5257.789688412459, 5279.0, 5301.0, 5242.370915490127, 5285.841424757264, 5294.788208471657, 5297.073012222845, 5319.281896943901, 5140.203268493389, 5214.06146893559, 5292.311999440049, 5307.495787900143, 5315.867103322409, 5722.828315150552, 5736.799212027559, 5751.166080918243, 5761.971190144064, 5784.132380143013, 5608.298962629671, 5857.414258574151, 6100.115483254947, 6174.598651087665, 6177.66022868742, 6178.10417489466, 6182.103594978747, 6210.285817130997, 6220.87558248837, 6328.303886572473, 5144.459831717653, 5815.313559067865, 5886.470217680429, 5948.851278718067, 5992.820215393545, 6171.84570385735, 6263.561550691408, 6270.184875966095, 6273.18448601688, 6278.277998030194, 6123.923256659767, 6131.468419844996, 6172.567920245539, 6189.226346706661, 6203.7828675996125, 6166.784162554289, 6188.659623720739, 6189.659568723673, 6232.065190221503, 6235.844103897439, 6139.369480960552, 6139.723712432951, 6143.419763699168, 6191.164192834, 6200.0699895016105, 6139.386061393914, 6156.353582873823, 6163.9383606164265, 6175.475084617858, 6192.287886893065, 4542.409486766699, 4958.107540642719, 5001.024800163933, 5014.147594908874, 5015.498450154955, 3517.067976986101, 4418.80115394808, 4458.264386376277, 4548.840790572314, 4607.562281583244, 4961.231009193581, 5024.924626130611, 5206.219067139884, 5961.850953726105, 5981.983062879321, 6208.627482351073, 6227.595206311666, 6229.53278504114, 6231.906521402183, 6235.345288744707, 5838.562107841929, 5935.910961335583, 5944.464998150101, 5959.672218027963, 5994.610350327302, 5475.151351540518, 5483.506484416342, 5497.532709719719, 5499.7250137492965, 5513.117901135799, 6237.937620623918, 6412.583182093149, 6444.387783160592, 6446.871062578816, 6552.246491653521, 6188.288346840171, 6247.718852651551, 6261.060840873905, 6267.592606480564, 6371.458426033839, 6415.550911436155, 6421.71102300407, 6421.8073457796345, 6429.4856411486035, 6437.034444833313, 6123.540734445023, 6124.908126378197, 6129.325774164749, 6159.23009623797, 6165.753369865334, 6135.600157732779, 6177.876442471215, 6192.164057852132, 6194.876102478015, 6205.596636218631, 6087.147799308189, 6105.84735381619, 6151.231096112986, 6155.1382806406245, 6177.660228687465, 5757.309122905278, 6095.634261944298, 6140.969295153495, 6156.322804491592, 6180.165677633462, 4858.368412106403, 5947.226860508279, 6010.669413182142, 6045.667488288186, 6105.297890742621, 6097.75608975636, 6139.631622102688, 6163.876722465436, 6172.629642221481, 6184.690765461799, 6011.699415029144, 6056.121862330026, 6101.237345331833, 6119.204503414528, 6138.357744607813], "value": 5670.161320683776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [515.0651567405162, 534.4228233507812, 577.5899111630742, 585.0551359554319, 609.18673570783, 37104.81447592762, 37844.0, 37946.24107517848, 37980.62019379805, 38085.42871856917, 32527.67472325276, 39461.80269098658, 39601.20797584054, 39820.60179398205, 40252.99367515813, 8440.0, 9491.857622135674, 9769.120779129877, 9780.657676981307, 9798.510074496247, 9566.712998610017, 9685.564149613285, 9687.951560242189, 9726.854097188549, 9752.951235243814, 9714.514274286257, 9729.270304727139, 9735.756606084833, 9781.706548803548, 9846.753831154207, 9714.562844671971, 9775.755606109904, 9779.266555008402, 9799.657012004545, 9809.656662016796, 9646.324757266993, 9676.322657413984, 9732.270079744048, 9736.853947190797, 9804.509774511318, 38126.428103578466, 38422.61577384218, 38686.0, 38700.225995480214, 38837.41743873844, 2803.3832556837465, 3054.69453054695, 3128.577642018321, 3356.647552007053, 3387.356402283583, 25313.36716582082, 25466.87266563674, 25524.23427297184, 26805.731942680715, 26843.86578067097, 2631.250218604626, 2641.313258552771, 2721.9047333343237, 2723.332783468043, 2783.3737409082996, 317653.0, 325361.0, 325769.0, 325818.37090814393, 327175.3641231802, 32465.675343246738, 32502.83748581242, 32672.0, 32713.0, 32772.83613581917, 34252.31495370129, 34933.30133397318, 35067.0, 35212.0, 35212.47181292283, 16711.415100471426, 17002.829971700372, 17512.38706645261, 17526.561835954202, 17541.473755787345, 12841.229526228457, 12870.871291287154, 13034.413451394521, 13056.21662700241, 13113.541026064042, 19203.519912002033, 19374.225030998885, 19396.32112876071, 19421.2231510738, 19449.222031118596, 6908.6545672716165, 7290.45321600882, 7937.801554961172, 8118.715844945398, 8190.262876341158, 669.5580916595023, 712.3232928717739, 833.6498670558381, 867.7461068755714, 874.5277550122989, 29285.974990875642, 29601.555976660366, 29730.108096757132, 29800.480828810418, 29889.551656725165, 990.9653162139291, 1080.670395529371, 1115.760111576015, 1142.280363371071, 1154.0349085645512, 13589.660258493617, 13806.593911086486, 14932.0, 15070.623234419008, 15181.139159610126, 643940.0, 645775.0, 646839.0, 651828.0, 653222.0, 48433.515664842904, 58420.0, 58558.707206463696, 59284.40715592789, 59317.70341148267, 1293.6442478318538, 1464.1361596658023, 1469.6032071340892, 1480.8963372563817, 1486.6357742353193, 28328.433431330846, 28731.28171795722, 28771.424571508873, 28909.710902890703, 29306.0, 43003.784981074896, 51038.489615103375, 51369.0, 52203.69490762609, 52251.47748522618, 575258.0, 579189.0, 581473.0, 581893.0, 581920.0, 26414.735852641228, 26643.866780665972, 26665.20004399871, 26817.597736034364, 26876.865615671795, 44304.320757066365, 44910.55089449194, 44982.0, 46411.76794116008, 46471.535284648075, 36595.26809463849, 37452.812735936146, 37693.0, 38067.23865522619, 38359.04102397351, 36863.81568092143, 36908.0, 37325.6267437333, 37337.81331093327, 37604.435933460474, 36098.45852312165, 36654.26691466209, 36826.26347473089, 37182.0, 37401.4389784148, 27967.860160699067, 32651.673483265815, 32798.50802238016, 33006.0, 33141.0, 24585.508289833746, 24617.876910615334, 24721.0, 24898.12856550012, 25007.0], "value": 18689.039618175186, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.8616039744499, 381.13292260108267, 387.0362796636375, 393.15079428434586, 396.2847061054795, 19588.90205548972, 20684.48288792777, 21221.57556848864, 21248.787512124873, 21279.361619151412, 19491.317803876867, 20136.0, 20235.291764788235, 20720.585588288264, 20863.47841303968, 5600.467955544217, 5870.3542610312725, 5924.703764811764, 5935.49548288396, 6068.271807383098, 4973.278874563186, 5932.11018347247, 5966.37353077927, 5987.970060149715, 6001.039833626621, 5231.633785635007, 5847.26909136358, 5899.498542623882, 5906.0, 5915.852103697399, 5703.458171473703, 5811.82564523065, 5876.764929402819, 5890.028145356033, 5922.022866227067, 4985.52637499437, 5055.721935293557, 5066.518680725325, 5116.104681680691, 5175.637705360627, 25259.368515787253, 25406.856691448927, 25480.0, 25498.0, 26351.68241587932, 1808.1953530678852, 2119.109973811003, 2127.106615221611, 2179.466030822443, 2756.986215068932, 14613.70772584553, 14688.853111468856, 14889.255537223204, 15031.173285469295, 15147.772783408147, 1681.697294486992, 1723.4829551134735, 1757.165346460421, 1760.4014635024025, 1772.53027947594, 101801.49099254457, 101839.92640294453, 102012.0, 102303.0, 103330.99999999924, 9239.584218710173, 11144.60993865211, 11380.772384552429, 11461.828072578752, 11589.594364197214, 14019.0, 14209.78685319721, 14217.715645687234, 14231.573052808433, 14232.21722805235, 8742.956285218661, 8857.424267422726, 8916.777080572907, 8921.821563568692, 8952.373333866697, 8970.730878073538, 8981.685641002534, 8992.46045237288, 8998.415103018282, 9016.639334426549, 6738.719643267764, 6822.351876571718, 6855.931440685629, 6870.828229294308, 6891.104156459728, 1855.7123645834918, 1860.5441666791723, 1873.5128866494538, 1901.9334323298617, 1940.1560321260297, 897.3852910756153, 949.292776881228, 981.5141504955093, 986.3785814936545, 996.8355221388534, 20742.688859667116, 21454.678179827315, 21470.78529214719, 21537.461563460725, 21632.459188520414, 811.9837603247902, 907.2197909797569, 951.8952915179325, 976.1556253840519, 1036.1555332404066, 11119.166062545342, 11543.134264929995, 11569.479373428216, 11572.132090093277, 11585.015273701661, 505918.0, 591170.0, 614239.0, 615062.0, 617034.0, 78593.60703196448, 102442.36566988887, 111901.88098119077, 146492.0, 147803.0, 888.600129941516, 982.4400091947522, 990.4008075114452, 991.1624677147798, 1008.4201584089031, 18504.537386565444, 18675.066246687882, 18720.0, 18767.530811729815, 18825.529361766065, 55170.0, 55328.89342213214, 55664.72167639136, 56328.71835640795, 56774.729010840754, 79754.0, 80051.79922301287, 80511.19488805038, 82407.0, 82607.93480163044, 5455.236266922555, 5731.799387021434, 7964.522128672298, 8073.475224110414, 8138.145494722969, 10955.56177752881, 11880.405979701154, 12206.145569810027, 12631.93684031574, 12840.357982100672, 10723.410212438392, 10887.455627218766, 10891.237613367306, 10989.945050274697, 11083.390413527333, 10673.199510036933, 10678.359298442118, 10712.14302855754, 10891.727706807393, 10950.945245273722, 11090.170121929792, 11405.144614154138, 11517.02105321057, 11538.769224615293, 11646.0, 6143.508519318533, 7336.853262934818, 7811.672015757448, 8041.798955026171, 8075.394345424234, 10168.491575421347, 10847.40339281347, 10918.617848375268, 11182.88817111851, 11191.832122518332], "value": 9637.280030048953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.8115026196858, 1643.515163026907, 1829.277435413011, 1897.487678326851, 1915.789263181049, 8073.0, 8661.350398720098, 8684.392092553524, 8936.061713520076, 8944.463332200072, 8636.870446943285, 8698.695545655903, 8753.781155471117, 8766.649334026648, 8794.252488538483, 1977.6736838421643, 2132.7867213278705, 2241.047554789216, 2439.548683493555, 2452.6443665668467, 2103.3479621317365, 2419.4072452249225, 2420.177139772477, 2430.562498750224, 2447.3881529617597, 2416.347586151738, 2434.85390876548, 2443.4746529496156, 2449.1183174057323, 2449.301948944551, 2195.2536137713255, 2273.011240110557, 2417.443987882788, 2427.4416884116663, 2428.720697119836, 2357.610994185957, 2390.09176512924, 2397.113068164773, 2416.371743346725, 2425.854448733082, 8719.084496127878, 8827.602757875848, 8921.241694455914, 8925.776855578597, 8943.060978597283, 5247.816326428557, 5323.733813309358, 5418.4039755626845, 5425.240466334716, 5453.481919217668, 3510.2102027043966, 3530.858765649371, 3549.343371476285, 3573.8391772370305, 3576.856925722968, 998.9100980911753, 1015.0509273828993, 1016.7051555049027, 1024.211357254917, 1029.696239609317, 11369.374684392355, 11537.192396532246, 11539.826902596384, 11584.362860042695, 11587.942060289728, 4223.619874211336, 4656.883577910579, 4678.391809064799, 4894.755262236874, 4914.852554423373, 9823.312368134304, 9827.066428689262, 9840.458774767314, 9847.212223022141, 9866.80266394668, 5362.142057270896, 5384.273123128406, 5399.4600539945695, 5435.809746658848, 5436.374816896028, 4320.546342634041, 4343.609075183249, 4882.072406242803, 4931.112399768076, 4937.11131996237, 4052.4124002019544, 4079.653229475528, 4082.3060079786505, 4181.184668989578, 4209.6000879916355, 1344.327836081959, 1356.2066191278213, 1357.5406438079106, 1361.4418088583634, 1368.3090039529973, 816.6447595296065, 878.4509681449094, 911.4667919267303, 933.4166146158651, 942.6512190489562, 5790.160426738184, 5933.851653708692, 5938.435848594377, 6037.698115094227, 6222.439980401786, 436.9628581570602, 457.3756821938031, 470.6940488682384, 474.65587449099814, 475.1020571120585, 3607.9098022549647, 3884.0678237222864, 3950.4074388841905, 4030.455888455021, 4033.616806403387, 10450.372977621368, 11000.724981875517, 11003.394813285186, 11070.169737269576, 11094.778104438028, 10731.2488125832, 10827.24209305341, 10874.945625271981, 10943.507542160622, 11020.50407731654, 8086.474379165335, 8148.796280092926, 8181.140980196994, 8285.461445006176, 8319.958400208081, 5477.3427188737605, 5893.410658934073, 5976.731047102978, 5990.940090599038, 6048.12302216185, 9956.904740478396, 9990.200783937413, 10013.2490063247, 10146.644867429604, 10184.847227291448, 9372.625094996123, 9831.705048848546, 10053.49732513386, 10311.123554497952, 10390.428526431118, 6312.5265605078885, 6914.0666010088, 7359.300866417681, 7520.360769334668, 7674.309312161932, 8038.598070096355, 8205.876911846208, 8310.70912518059, 8322.292605128632, 8366.748997530083, 7238.348548630648, 7300.598467084362, 7361.926380736339, 7433.628318584158, 7518.924810751822, 7248.483032436971, 7346.6693998769115, 7422.777316680508, 7423.035005449257, 7457.850842983218, 5459.344878614433, 6131.509479241739, 6617.569857959217, 6978.79063628092, 7024.824379390556, 4791.113643975876, 4909.189983652657, 4940.456549779593, 5036.697798132123, 5156.716380598953, 4959.231319145538, 4987.875303117451, 5054.949450505448, 5115.667481613832, 5317.654352467077], "value": 4514.890756512614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.20981252493016, 287.1801008121812, 303.02879271933455, 307.166044190024, 307.2671678047855, 5183.688978661283, 5207.531322181003, 5500.944990550103, 5668.716564171796, 6236.220472440945, 6173.567850250484, 6221.564490485668, 6229.190205273319, 6242.781502647408, 6257.124002639634, 4534.9546504534865, 4561.156186105564, 4583.19794036044, 4584.19776539106, 4625.213713668684, 3458.4120699481023, 3665.8350374233223, 4391.538888416718, 4467.17357288901, 4553.453585569736, 4431.689781715281, 4434.467863856342, 4438.356438316442, 4440.53638162234, 4462.995825939171, 4466.553344665524, 4478.440194975628, 4484.529124441952, 4485.170243504962, 4532.592066714012, 3677.7793332400142, 3764.8305826237884, 3771.7171212159196, 3802.657760801541, 3807.067268519203, 4520.073384956077, 5373.489518495737, 5550.139728342114, 5880.4119588041285, 5914.349421563625, 4435.733855968652, 4478.149151661174, 5184.7148406837605, 5196.155364845463, 5252.0, 6208.441240288351, 6566.8508011097865, 6589.604623722592, 6596.373344532261, 6683.5655682380975, 3777.244551089793, 4036.2936486115104, 4186.6859985500905, 4222.493300803892, 4273.4444522212225, 6833.5216534843075, 6937.791866244021, 6953.443724502028, 7023.051887995158, 7027.613481258529, 3757.380032294641, 4175.97912010438, 4251.829926802955, 4254.361845723166, 4268.701190916669, 4279.229738647074, 4327.874752564356, 4337.587929146726, 4340.6110044786, 4346.782660866944, 5159.0, 5159.896802063938, 5175.534201921845, 5181.171012637959, 5181.2746215529105, 5574.58190635704, 5683.943160568424, 6318.810435686937, 6338.239411270677, 6514.599361137378, 1462.656275775192, 1462.7201198950918, 1480.7630779075296, 1481.140938255809, 1513.3038802150913, 800.1838125112353, 918.5177781664679, 937.2174234514121, 938.4556956964944, 960.5869476125333, 5188.92216616751, 5210.400803907523, 6128.0, 6152.8769424611255, 6166.660833654192, 5803.7388317524965, 6872.0, 6892.0, 6893.862122757617, 6918.308169183041, 5848.385919478478, 6169.444749972435, 6224.253089629183, 6267.905981410283, 6284.811455656338, 3624.4382120771324, 3643.544556930384, 3671.8714844980295, 3673.4306182541213, 3695.2978934002454, 5816.709164541756, 6015.939840601625, 7198.424126069902, 7251.601161936144, 7274.30894065063, 7008.0, 7147.9285207148305, 7169.6773645186095, 7180.748673796392, 7235.803234124195, 6029.78895738647, 6712.328767123347, 6866.656667166621, 7221.386182174574, 7238.565686058853, 6814.625195614289, 6890.44876409876, 6968.895466568107, 6970.546914450544, 6984.755533556301, 5868.589198756046, 6439.7424103035355, 6808.0, 6812.012258222431, 6963.79108626742, 6155.630662160105, 7242.094738157731, 7356.0, 7422.294881986203, 7425.628718564159, 4008.779517126586, 4305.48334199898, 4310.612044915973, 4323.956760432356, 4346.500152482505, 5955.880882382241, 6577.6053436793945, 6736.461083113437, 6966.407855332353, 6974.651267436507, 5755.971220143872, 6706.195256569243, 6749.392554670103, 6766.729330826712, 6813.012113243651, 6028.457438830526, 6512.153420055552, 6683.930571108599, 6745.662716864039, 6749.628770417674, 5931.602241959796, 6155.876882462236, 6420.1974753155855, 6524.119243902012, 6574.967125164535, 5700.771969121354, 6713.530052896251, 6760.459163266829, 6780.762673306411, 6833.248342682202, 6291.496680265476, 6376.840578985562, 6538.542302038812, 6558.80323590293, 6618.966905165444], "value": 4707.167813793791, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.4731167754118, 658.9835254118647, 741.788590251778, 745.4260219630881, 764.8049747314437, 14804.037737547053, 14952.476663316786, 15156.24218789059, 15270.694586108271, 15351.462698805544, 13924.721505569882, 13955.372008259626, 13963.232022238773, 13966.30168491574, 14047.016708830386, 709.7657772934945, 763.7097902796929, 878.547548012774, 898.7034278688018, 900.7658008917696, 809.0453265147124, 894.472261365794, 897.2507955856835, 897.443584977315, 901.4591245252828, 738.401894465482, 822.6503735912213, 846.5132548784443, 904.5612877754284, 972.951352432379, 945.5225111318808, 957.0764212534938, 957.1051067252141, 964.7202311329706, 965.8454647256441, 708.8582283543312, 712.3304094151481, 717.3866344275622, 720.7009091227135, 725.4124159430878, 12365.31990740509, 14332.140071595633, 14709.11745295275, 14716.264186790617, 14760.335784889598, 12814.038947078912, 12819.615411537576, 12945.87054129456, 13226.272555009567, 13315.134516256509, 10072.899271007269, 10087.142592879614, 10139.188864890792, 10372.63695770652, 10484.318519296221, 3497.422925217336, 3503.1592417819793, 3521.0845180253064, 3546.0, 3573.749837511375, 58355.41644583542, 64435.0, 77775.61112194459, 81072.59463702644, 81766.59116704437, 9293.90706092944, 9491.525423728786, 9492.050794920453, 9651.227901767841, 9683.370580912218, 21907.26159230096, 21969.340919772432, 22063.0, 22614.869256537437, 22639.886800566223, 6336.52476064297, 7405.306423040998, 7424.220456852061, 7703.460757746904, 7704.26809453101, 3991.1419044905483, 4048.0689441428635, 4085.571015043437, 4092.8567500137947, 4101.610347017028, 3475.461303497962, 3522.735794815399, 3527.4885141654318, 3559.60844307126, 3595.065283026432, 567.4750855458684, 633.7148283272546, 650.8828410886086, 660.7489154121499, 664.2925284571916, 485.965982381237, 514.6466866532649, 518.9931532826305, 559.1640497456328, 572.6678526454647, 7907.723229686933, 7985.5208687478935, 8002.439829211899, 8163.959180204061, 8219.178082191853, 559.9836297120794, 577.7717801468397, 583.9562032847554, 589.4753669234385, 590.2061726977208, 3721.6650501454455, 3867.651911327994, 3899.239648268617, 3908.4332771747936, 3923.097687531884, 78815.0, 92679.0, 94954.0, 95225.0, 95447.52276238575, 50607.74696126496, 67610.30974225585, 68616.31383686198, 71399.92900106503, 72679.0, 53859.0, 61807.145785626504, 62478.0, 63173.05240421397, 63814.36185638177, 7998.320142787696, 8017.518948863087, 8143.900573422512, 8145.348372130097, 8325.916740832514, 40747.0, 42137.0, 43975.0, 44051.77974110109, 44394.0, 64510.0, 65501.344986551434, 65789.67105164635, 65928.3517912056, 66378.66810665916, 10389.792204156025, 10644.467776610983, 10668.359898406121, 10743.08683761889, 10993.835092473779, 11848.933595976403, 11855.881441185478, 12226.633201003984, 12236.816447753468, 12459.0, 10784.299020563638, 11701.707457313294, 11702.063834893359, 11839.76320473603, 12158.148929574845, 10620.15038796879, 11272.0, 11306.94346528262, 11468.19722619442, 12206.6948326289, 11080.39057851826, 11101.333919964827, 11130.666080017612, 11167.609133680282, 11239.438028098399, 9395.671151509665, 9441.055894410503, 9501.382410143595, 9637.662681806103, 9788.657396991071, 9285.72142835716, 9528.142467177988, 9568.712938611852, 9601.855972160563, 9638.662646807608], "value": 6726.657276819377, "unit": "score"}], "name": "dromaeo_css", "value": 7256.552130692369, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 119.0, 117.0, 119.0, 130.0, 117.0, 155.0, 171.0, 117.0], "value": 127.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 120.0, 147.0, 163.0, 123.0, 137.0, 141.0, 141.0, 163.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 206.0, 216.0, 234.0, 252.0, 203.0, 195.0, 201.0, 201.0, 264.0], "value": 216.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 74.0, 135.0, 76.0, 81.0, 86.0, 54.0, 66.0, 62.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 115.0, 167.0, 106.0, 83.0, 84.0, 124.0, 109.0, 113.0, 146.0], "value": 112.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 98.0, 112.0, 90.0, 79.0, 131.0, 88.0, 90.0, 87.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 96.0, 96.0, 95.0, 101.0, 96.0, 98.0, 95.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 91.0, 95.0, 94.0, 93.0, 94.0, 122.0, 128.0], "value": 100.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 61.0, 60.0, 61.0, 57.0, 64.0, 79.0, 66.0, 61.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 73.0, 73.0, 77.0, 74.0, 68.0, 93.0, 97.0, 92.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 99.0, 107.0, 105.0, 100.0, 86.0, 84.0, 83.0, 83.0, 83.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 151.0, 159.0, 156.0, 158.0, 157.0, 149.0, 139.0, 203.0, 175.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 173.0, 175.0, 171.0, 175.0, 174.0, 176.0, 178.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 68.0, 69.0, 74.0, 70.0, 68.0, 87.0, 86.0, 71.0], "value": 73.8, "unit": "score"}], "name": "kraken", "value": 1612.8, "alertThreshold": 2.0}]} 21:34:32 INFO - Return code: 0 21:34:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:34:32 ERROR - # TBPL SUCCESS # 21:34:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:32 INFO - 2016-04-21 21:34:32.441 screenresolution[1957:17563] starting screenresolution argv=screenresolution get 21:34:32 INFO - 2016-04-21 21:34:32.443 screenresolution[1957:17563] Display 0: 1600x1200x32@60 21:34:32 INFO - 2016-04-21 21:34:32.449 screenresolution[1958:17566] starting screenresolution argv=screenresolution list 21:34:32 INFO - Available Modes on Display 0 21:34:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:32 INFO - Intel Iris: 21:34:32 INFO - Chipset Model: Intel Iris 21:34:32 INFO - Type: GPU 21:34:32 INFO - Bus: Built-In 21:34:32 INFO - VRAM (Dynamic, Max): 1536 MB 21:34:32 INFO - Vendor: Intel (0x8086) 21:34:32 INFO - Device ID: 0x0a2e 21:34:32 INFO - Revision ID: 0x0009 21:34:32 INFO - Displays: 21:34:32 INFO - Display: 21:34:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:32 INFO - Display Serial Number: 1600x1200 60 21:34:32 INFO - Main Display: Yes 21:34:32 INFO - Mirror: Off 21:34:32 INFO - Online: Yes 21:34:32 INFO - Rotation: Supported 21:34:32 INFO - Return code: 0 21:34:32 INFO - Running post-action listener: _resource_record_post_action 21:34:32 INFO - Running post-run listener: _resource_record_post_run 21:34:33 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 544768; Write bytes: 699750912; Read time: 8; Write time: 1947 21:34:33 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395493888; Write bytes: 396944384; Read time: 29560; Write time: 694 21:34:33 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 544768; Write bytes: 300380160; Read time: 8; Write time: 1188 21:34:33 INFO - Running post-run listener: _upload_blobber_files 21:34:33 INFO - Blob upload gear active. 21:34:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:34:33 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 21:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:34:34 INFO - (blobuploader) - INFO - Open directory for files ... 21:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:35 INFO - (blobuploader) - INFO - Done attempting. 21:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:34:36 INFO - (blobuploader) - INFO - Done attempting. 21:34:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:34:36 INFO - Return code: 0 21:34:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:34:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:34:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb7af8aa5f64ba73bde557b97819753184b4eff040229026f3b0a511763d02a998ea164446efc43d4d52dbeb02a25bed57f3579f6987317f23416681dbdb6085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7807ba9e44021ae6773d8170828cf0518fc8ea447897e3df87152ed46b604cda9da03826b7755a2bc610f05acaae8f609f8934dacd76c09aa5e92d4c96c7a32d"} 21:34:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:34:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:34:36 INFO - Contents: 21:34:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb7af8aa5f64ba73bde557b97819753184b4eff040229026f3b0a511763d02a998ea164446efc43d4d52dbeb02a25bed57f3579f6987317f23416681dbdb6085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7807ba9e44021ae6773d8170828cf0518fc8ea447897e3df87152ed46b604cda9da03826b7755a2bc610f05acaae8f609f8934dacd76c09aa5e92d4c96c7a32d"} 21:34:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:34:36 INFO - Copying logs to upload dir... 21:34:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:34:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.830892 ========= master_lag: 747.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 33 mins, 33 secs) (at 2016-04-21 21:47:04.048681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 21:47:04.052333) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb7af8aa5f64ba73bde557b97819753184b4eff040229026f3b0a511763d02a998ea164446efc43d4d52dbeb02a25bed57f3579f6987317f23416681dbdb6085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7807ba9e44021ae6773d8170828cf0518fc8ea447897e3df87152ed46b604cda9da03826b7755a2bc610f05acaae8f609f8934dacd76c09aa5e92d4c96c7a32d"} build_url:https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011760 build_url: 'https://queue.taskcluster.net/v1/task/diEbyJz1TDWrCMVoKM_gaw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eb7af8aa5f64ba73bde557b97819753184b4eff040229026f3b0a511763d02a998ea164446efc43d4d52dbeb02a25bed57f3579f6987317f23416681dbdb6085", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7807ba9e44021ae6773d8170828cf0518fc8ea447897e3df87152ed46b604cda9da03826b7755a2bc610f05acaae8f609f8934dacd76c09aa5e92d4c96c7a32d"}' ========= master_lag: 0.62 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 21:47:04.683848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 38 secs) (at 2016-04-21 21:47:04.684310) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZVeM7wQuyb/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.cyAFV34sIE/Listeners TMPDIR=/var/folders/6x/fp43dmc567bb9pghsl0yp6g400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005339 ========= master_lag: 38.78 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 38 secs) (at 2016-04-21 21:47:43.469559) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 21:47:43.469977) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 21:47:44.119056) ========= ========= Total master_lag: 824.11 =========