builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0143 starttime: 1457343268.72 results: success (0) buildid: 20160307003410 builduid: 4345bf71236e40d0a96860ec58265517 revision: 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.717998) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.718490) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.718784) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005594 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.742455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.742760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.760079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.760425) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005691 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.925590) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.925892) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.926270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:28.926549) ========= 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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03-07 01:34:28-- 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% 170M=0s 2016-03-07 01:34:29 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100994 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:29.043284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:29.043597) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.025419 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:29.092422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 01:34:29.092766) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d --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 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-03-07 01:34:29,164 truncating revision to first 12 chars 2016-03-07 01:34:29,164 Setting DEBUG logging. 2016-03-07 01:34:29,164 attempt 1/10 2016-03-07 01:34:29,164 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ee60bdfe6b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 01:34:30,229 unpacking tar archive at: fx-team-5ee60bdfe6b8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 01:34:30.421421) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:30.421753) ========= echo 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d program finished with exit code 0 elapsedTime=0.005486 script_repo_revision: '5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:30.471369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:30.471691) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-07 01:34:30.484318) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-07 01:34:30.484756) ========= /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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:34:30 INFO - MultiFileLogger online at 20160307 01:34:30 in /builds/slave/test 01:34: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 01:34:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:34:30 INFO - {'append_to_log': False, 01:34:30 INFO - 'base_work_dir': '/builds/slave/test', 01:34:30 INFO - 'blob_upload_branch': 'Fx-Team', 01:34:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:34:30 INFO - 'branch': 'Fx-Team', 01:34:30 INFO - 'buildbot_json_path': 'buildprops.json', 01:34:30 INFO - 'config_files': ('talos/mac_config.py',), 01:34:30 INFO - 'default_actions': ('clobber', 01:34:30 INFO - 'read-buildbot-config', 01:34:30 INFO - 'download-and-extract', 01:34:30 INFO - 'populate-webroot', 01:34:30 INFO - 'create-virtualenv', 01:34:30 INFO - 'install', 01:34:30 INFO - 'run-tests'), 01:34:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:34:30 INFO - 'download_minidump_stackwalk': True, 01:34:30 INFO - 'download_symbols': 'ondemand', 01:34:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:34:30 INFO - 'tooltool.py': '/tools/tooltool.py', 01:34:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:34:30 INFO - '/tools/misc-python/virtualenv.py')}, 01:34:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:34:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:34:30 INFO - 'installer_path': 'installer.exe', 01:34:30 INFO - 'log_level': 'info', 01:34:30 INFO - 'log_name': 'talos', 01:34:30 INFO - 'log_to_console': True, 01:34:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:34:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:34:30 INFO - 'opt_config_files': (), 01:34:30 INFO - 'pip_index': False, 01:34:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:34:30 INFO - 'cmd': ('bash', 01:34:30 INFO - '-c', 01:34:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:34:30 INFO - 'enabled': True, 01:34:30 INFO - 'halt_on_failure': False, 01:34:30 INFO - 'name': 'check_screen_resolution'},), 01:34:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:34:30 INFO - 'cmd': ('bash', 01:34:30 INFO - '-c', 01:34:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:34:30 INFO - 'enabled': True, 01:34:30 INFO - 'halt_on_failure': False, 01:34:30 INFO - 'name': 'check_screen_resolution'},), 01:34:30 INFO - 'run_cmd_checks_enabled': True, 01:34:30 INFO - 'sps_profile': False, 01:34:30 INFO - 'sps_profile_interval': 0, 01:34:30 INFO - 'suite': 'dromaeojs-e10s', 01:34:30 INFO - 'system_bits': '32', 01:34:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:34:30 INFO - 'title': 't-yosemite-r7-0143', 01:34:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:34:30 INFO - 'use_talos_json': True, 01:34:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:34:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:34:30 INFO - 'work_dir': 'build'} 01:34:30 INFO - ##### 01:34:30 INFO - ##### Running clobber step. 01:34:30 INFO - ##### 01:34:30 INFO - Running pre-action listener: _resource_record_pre_action 01:34:30 INFO - Running main action method: clobber 01:34:30 INFO - rmtree: /builds/slave/test/build 01:34:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:34:32 INFO - Running post-action listener: _resource_record_post_action 01:34:32 INFO - ##### 01:34:32 INFO - ##### Running read-buildbot-config step. 01:34:32 INFO - ##### 01:34:32 INFO - Running pre-action listener: _resource_record_pre_action 01:34:32 INFO - Running main action method: read_buildbot_config 01:34:32 INFO - Using buildbot properties: 01:34:32 INFO - { 01:34:32 INFO - "project": "", 01:34:32 INFO - "product": "firefox", 01:34:32 INFO - "script_repo_revision": "production", 01:34:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:34:32 INFO - "repository": "", 01:34:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:34:32 INFO - "buildid": "20160307003410", 01:34:32 INFO - "pgo_build": "False", 01:34:32 INFO - "basedir": "/builds/slave/test", 01:34:32 INFO - "buildnumber": 464, 01:34:32 INFO - "slavename": "t-yosemite-r7-0143", 01:34:32 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:34:32 INFO - "platform": "yosemite_r7", 01:34:32 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:34:32 INFO - "branch": "fx-team", 01:34:32 INFO - "repo_path": "integration/fx-team", 01:34:32 INFO - "revision": "5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d", 01:34:32 INFO - "stage_platform": "macosx64", 01:34:32 INFO - "builduid": "4345bf71236e40d0a96860ec58265517", 01:34:32 INFO - "slavebuilddir": "test" 01:34:32 INFO - } 01:34:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:34:32 INFO - Running post-action listener: _resource_record_post_action 01:34:32 INFO - ##### 01:34:32 INFO - ##### Running download-and-extract step. 01:34:32 INFO - ##### 01:34:32 INFO - Running pre-action listener: _resource_record_pre_action 01:34:32 INFO - Running main action method: download_and_extract 01:34:32 INFO - mkdir: /builds/slave/test/build/tests 01:34: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')]} 01:34:32 INFO - https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 01:34:32 INFO - Downloaded 1277 bytes. 01:34:32 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:34:32 INFO - Using the following test package requirements: 01:34:32 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:34:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:34:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:34:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'jsshell-mac.zip'], 01:34:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:34:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:34:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:34:32 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:34:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:34:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:34:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:34:32 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:34:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:34: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')]} 01:34:32 INFO - https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:34:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:34:33 INFO - Downloaded 17866159 bytes. 01:34:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:34:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:34:37 INFO - Return code: 0 01:34:37 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:34:37 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')]} 01:34:37 INFO - https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:34:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:34:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:34:38 INFO - Downloaded 17866159 bytes. 01:34:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:34:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:34:41 INFO - Return code: 0 01:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:34:41 INFO - https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:34:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:34:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:34:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:34:42 INFO - Downloaded 10845161 bytes. 01:34:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:34:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:34:42 INFO - Return code: 0 01:34: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')]} 01:34:42 INFO - https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:34:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:34:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:34:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:34:45 INFO - Downloaded 111016086 bytes. 01:34:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:34:45 INFO - mkdir: /builds/slave/test/properties 01:34:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:34:45 INFO - Writing to file /builds/slave/test/properties/build_url 01:34:45 INFO - Contents: 01:34:45 INFO - build_url:https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:34:46 INFO - Running post-action listener: _resource_record_post_action 01:34:46 INFO - Running post-action listener: set_extra_try_arguments 01:34:46 INFO - ##### 01:34:46 INFO - ##### Running populate-webroot step. 01:34:46 INFO - ##### 01:34:46 INFO - Running pre-action listener: _resource_record_pre_action 01:34:46 INFO - Running main action method: populate_webroot 01:34:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:34:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:34:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:34:46 INFO - '--tppagecycles', 01:34:46 INFO - '7'], 01:34:46 INFO - 'tests': ['tsvgm']}}, 01:34:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:34:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:34:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:34:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:34:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:34:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'tests': ['damp', 'tps']}, 01:34:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['damp', 'tps']}, 01:34:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:34:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:34:46 INFO - 'other': {'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'other_l64': {'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'other_nol64': {'tests': ['a11yr', 01:34:46 INFO - 'ts_paint', 01:34:46 INFO - 'tpaint', 01:34:46 INFO - 'sessionrestore', 01:34:46 INFO - 'sessionrestore_no_auto_restore', 01:34:46 INFO - 'tabpaint']}, 01:34:46 INFO - 'svgr': {'tests': ['tsvgx', 01:34:46 INFO - 'tsvgr_opacity', 01:34:46 INFO - 'tart', 01:34:46 INFO - 'tscrollx', 01:34:46 INFO - 'cart']}, 01:34:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['tsvgx', 01:34:46 INFO - 'tsvgr_opacity', 01:34:46 INFO - 'tart', 01:34:46 INFO - 'tscrollx', 01:34:46 INFO - 'cart']}, 01:34:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'tests': ['tp5o']}, 01:34:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'talos_options': ['--e10s'], 01:34:46 INFO - 'tests': ['tp5o']}, 01:34:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'talos_options': ['--xperf_path', 01:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:46 INFO - 'tests': ['tp5n']}, 01:34:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:34:46 INFO - 'talos_options': ['--e10s', 01:34:46 INFO - '--xperf_path', 01:34:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:34:46 INFO - 'tests': ['tp5n']}}, 01:34:46 INFO - 'talos.zip': {'path': '', 01:34:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:34:46 INFO - Running post-action listener: _resource_record_post_action 01:34:46 INFO - ##### 01:34:46 INFO - ##### Running create-virtualenv step. 01:34:46 INFO - ##### 01:34:46 INFO - Running pre-action listener: _resource_record_pre_action 01:34:46 INFO - Running main action method: create_virtualenv 01:34:46 INFO - Creating virtualenv /builds/slave/test/build/venv 01:34:46 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 01:34:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:34:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:34:46 INFO - Using real prefix '/tools/python27' 01:34:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:34:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:34:50 INFO - Installing pip.................done. 01:34:50 INFO - Return code: 0 01:34:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:34:50 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')]} 01:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:50 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')]} 01:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:50 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:34:50 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 01:34:50 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 01:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:50 INFO - 'HOME': '/Users/cltbld', 01:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:50 INFO - 'LOGNAME': 'cltbld', 01:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:50 INFO - 'MOZ_NO_REMOTE': '1', 01:34:50 INFO - 'NO_EM_RESTART': '1', 01:34:50 INFO - 'PAGER': '/bin/cat', 01:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:50 INFO - 'PWD': '/builds/slave/test', 01:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:50 INFO - 'SHELL': '/bin/bash', 01:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:34:50 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:50 INFO - 'USER': 'cltbld', 01:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:50 INFO - 'XPC_FLAGS': '0x0', 01:34:50 INFO - 'XPC_SERVICE_NAME': '0', 01:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:50 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 01:34:50 INFO - Cleaning up... 01:34:50 INFO - Return code: 0 01:34:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:34:50 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')]} 01:34:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:50 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')]} 01:34:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:50 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:34:50 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 01:34:50 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 01:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:50 INFO - 'HOME': '/Users/cltbld', 01:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:50 INFO - 'LOGNAME': 'cltbld', 01:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:50 INFO - 'MOZ_NO_REMOTE': '1', 01:34:50 INFO - 'NO_EM_RESTART': '1', 01:34:50 INFO - 'PAGER': '/bin/cat', 01:34:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:50 INFO - 'PWD': '/builds/slave/test', 01:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:50 INFO - 'SHELL': '/bin/bash', 01:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:34:50 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:50 INFO - 'USER': 'cltbld', 01:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:50 INFO - 'XPC_FLAGS': '0x0', 01:34:50 INFO - 'XPC_SERVICE_NAME': '0', 01:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:50 INFO - Downloading/unpacking psutil>=0.7.1 01:34:50 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 01:34:50 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 01:34:50 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 01:34:50 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 01:34:50 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 01:34:50 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 01:34:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:34:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:53 INFO - Installing collected packages: psutil 01:34:53 INFO - Running setup.py install for psutil 01:34:53 INFO - building 'psutil._psutil_osx' extension 01:34:53 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 01:34:54 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 01:34:54 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 01:34:54 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 01:34:54 INFO - building 'psutil._psutil_posix' extension 01:34:54 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 01:34:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:34:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:34:54 INFO - ^ 01:34:54 INFO - 1 warning generated. 01:34:54 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 01:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:34:54 INFO - Successfully installed psutil 01:34:54 INFO - Cleaning up... 01:34:54 INFO - Return code: 0 01:34:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:34: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')]} 01:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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')]} 01:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34: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', '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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:34: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:34: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 mozsystemmonitor==0.0.0 01:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:54 INFO - 'HOME': '/Users/cltbld', 01:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:54 INFO - 'LOGNAME': 'cltbld', 01:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:54 INFO - 'MOZ_NO_REMOTE': '1', 01:34:54 INFO - 'NO_EM_RESTART': '1', 01:34:54 INFO - 'PAGER': '/bin/cat', 01:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:54 INFO - 'PWD': '/builds/slave/test', 01:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:54 INFO - 'SHELL': '/bin/bash', 01:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:34:54 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:54 INFO - 'USER': 'cltbld', 01:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:54 INFO - 'XPC_FLAGS': '0x0', 01:34:54 INFO - 'XPC_SERVICE_NAME': '0', 01:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:34:55 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 01:34:55 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 01:34:55 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 01:34:55 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 01:34:55 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 01:34:55 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 01:34:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:34:57 INFO - Installing collected packages: mozsystemmonitor 01:34:57 INFO - Running setup.py install for mozsystemmonitor 01:34:57 INFO - Successfully installed mozsystemmonitor 01:34:57 INFO - Cleaning up... 01:34:57 INFO - Return code: 0 01:34:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:34:57 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')]} 01:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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')]} 01:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:57 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:34:57 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 01:34:57 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 01:34:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:34:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:34:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:34:57 INFO - 'HOME': '/Users/cltbld', 01:34:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:34:57 INFO - 'LOGNAME': 'cltbld', 01:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:57 INFO - 'MOZ_NO_REMOTE': '1', 01:34:57 INFO - 'NO_EM_RESTART': '1', 01:34:57 INFO - 'PAGER': '/bin/cat', 01:34:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:57 INFO - 'PWD': '/builds/slave/test', 01:34:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:34:57 INFO - 'SHELL': '/bin/bash', 01:34:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:34:57 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:34:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:34:57 INFO - 'USER': 'cltbld', 01:34:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:34:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:57 INFO - 'XPC_FLAGS': '0x0', 01:34:57 INFO - 'XPC_SERVICE_NAME': '0', 01:34:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:57 INFO - Downloading/unpacking blobuploader==1.2.4 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:34:57 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 01:35:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:35:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 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 01:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:35:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:01 INFO - Downloading docopt-0.6.1.tar.gz 01:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:35:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:35:01 INFO - Running setup.py install for blobuploader 01:35:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:35:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:35:01 INFO - Running setup.py install for requests 01:35:02 INFO - Running setup.py install for docopt 01:35:02 INFO - Successfully installed blobuploader requests docopt 01:35:02 INFO - Cleaning up... 01:35:02 INFO - Return code: 0 01:35:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:02 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:35:02 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 01:35:02 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 01:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:02 INFO - 'HOME': '/Users/cltbld', 01:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:02 INFO - 'LOGNAME': 'cltbld', 01:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:02 INFO - 'MOZ_NO_REMOTE': '1', 01:35:02 INFO - 'NO_EM_RESTART': '1', 01:35:02 INFO - 'PAGER': '/bin/cat', 01:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:02 INFO - 'PWD': '/builds/slave/test', 01:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:02 INFO - 'SHELL': '/bin/bash', 01:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:02 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:02 INFO - 'USER': 'cltbld', 01:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:02 INFO - 'XPC_FLAGS': '0x0', 01:35:02 INFO - 'XPC_SERVICE_NAME': '0', 01:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-KTv_zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-aSvbQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:02 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-13jtN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-SbOaxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-651haG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NcNl7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rDGFxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-2H7PyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-J6W4al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-uFiU6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-opETof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-8g4xrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:03 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-yfai72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:04 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-G5XRT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:04 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-zmCtq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:04 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4iZcS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:04 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-j4yYIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:35:04 INFO - Running setup.py install for manifestparser 01:35:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:35:04 INFO - Running setup.py install for mozcrash 01:35:04 INFO - Running setup.py install for mozdebug 01:35:04 INFO - Running setup.py install for mozdevice 01:35:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Running setup.py install for mozfile 01:35:05 INFO - Running setup.py install for mozhttpd 01:35:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Running setup.py install for mozinfo 01:35:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Running setup.py install for mozInstall 01:35:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Running setup.py install for mozleak 01:35:05 INFO - Running setup.py install for mozlog 01:35:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:35:05 INFO - Running setup.py install for moznetwork 01:35:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:35:06 INFO - Running setup.py install for mozprocess 01:35:06 INFO - Running setup.py install for mozprofile 01:35:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:35:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:35:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:35:06 INFO - Running setup.py install for mozrunner 01:35:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:35:06 INFO - Running setup.py install for mozscreenshot 01:35:06 INFO - Running setup.py install for moztest 01:35:06 INFO - Running setup.py install for mozversion 01:35:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:35:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:35:07 INFO - Cleaning up... 01:35:07 INFO - Return code: 0 01:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:07 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')]} 01:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:07 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')]} 01:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:07 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:35:07 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 01:35:07 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 01:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:07 INFO - 'HOME': '/Users/cltbld', 01:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:07 INFO - 'LOGNAME': 'cltbld', 01:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:07 INFO - 'MOZ_NO_REMOTE': '1', 01:35:07 INFO - 'NO_EM_RESTART': '1', 01:35:07 INFO - 'PAGER': '/bin/cat', 01:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:07 INFO - 'PWD': '/builds/slave/test', 01:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:07 INFO - 'SHELL': '/bin/bash', 01:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:07 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:07 INFO - 'USER': 'cltbld', 01:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:07 INFO - 'XPC_FLAGS': '0x0', 01:35:07 INFO - 'XPC_SERVICE_NAME': '0', 01:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Y_HaLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-iisWoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Bqo80n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-D1lw0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Ztjh24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-8QotCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:35:07 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)) 01:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:35:07 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-42IjOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-buI1M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-sBCX3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-yJOjzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-fA8ORX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gZTw2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-04JAnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-HOX_z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-82Qbru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:35:08 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)) 01:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:35:08 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-O2_KTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:35:09 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)) 01:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:35:09 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ci2VQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:35:09 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)) 01:35:09 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)) 01:35:09 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)) 01:35:09 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)) 01:35:09 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)) 01:35:09 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)) 01:35:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:11 INFO - Downloading blessings-1.6.tar.gz 01:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:35:11 INFO - Installing collected packages: blessings 01:35:11 INFO - Running setup.py install for blessings 01:35:11 INFO - Successfully installed blessings 01:35:11 INFO - Cleaning up... 01:35:11 INFO - Return code: 0 01:35:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:12 INFO - Reading from file tmpfile_stdout 01:35:12 INFO - Current package versions: 01:35:12 INFO - blessings == 1.6 01:35:12 INFO - blobuploader == 1.2.4 01:35:12 INFO - docopt == 0.6.1 01:35:12 INFO - manifestparser == 1.1 01:35:12 INFO - mozInstall == 1.12 01:35:12 INFO - mozcrash == 0.17 01:35:12 INFO - mozdebug == 0.1 01:35:12 INFO - mozdevice == 0.48 01:35:12 INFO - mozfile == 1.2 01:35:12 INFO - mozhttpd == 0.7 01:35:12 INFO - mozinfo == 0.9 01:35:12 INFO - mozleak == 0.1 01:35:12 INFO - mozlog == 3.1 01:35:12 INFO - moznetwork == 0.27 01:35:12 INFO - mozprocess == 0.22 01:35:12 INFO - mozprofile == 0.28 01:35:12 INFO - mozrunner == 6.11 01:35:12 INFO - mozscreenshot == 0.1 01:35:12 INFO - mozsystemmonitor == 0.0 01:35:12 INFO - moztest == 0.7 01:35:12 INFO - mozversion == 1.4 01:35:12 INFO - psutil == 3.1.1 01:35:12 INFO - requests == 1.2.3 01:35:12 INFO - wsgiref == 0.1.2 01:35:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:35:12 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')]} 01:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:12 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')]} 01:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:12 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:35:12 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 01:35:12 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 01:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:12 INFO - 'HOME': '/Users/cltbld', 01:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:12 INFO - 'LOGNAME': 'cltbld', 01:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:12 INFO - 'MOZ_NO_REMOTE': '1', 01:35:12 INFO - 'NO_EM_RESTART': '1', 01:35:12 INFO - 'PAGER': '/bin/cat', 01:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:12 INFO - 'PWD': '/builds/slave/test', 01:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:12 INFO - 'SHELL': '/bin/bash', 01:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:12 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:12 INFO - 'USER': 'cltbld', 01:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:12 INFO - 'XPC_FLAGS': '0x0', 01:35:12 INFO - 'XPC_SERVICE_NAME': '0', 01:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 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)) 01:35:12 INFO - Cleaning up... 01:35:12 INFO - Return code: 0 01:35:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:35:12 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')]} 01:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:12 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')]} 01:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:12 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 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:35:12 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 01:35:12 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 01:35:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:12 INFO - 'HOME': '/Users/cltbld', 01:35:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:12 INFO - 'LOGNAME': 'cltbld', 01:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:12 INFO - 'MOZ_NO_REMOTE': '1', 01:35:12 INFO - 'NO_EM_RESTART': '1', 01:35:12 INFO - 'PAGER': '/bin/cat', 01:35:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:12 INFO - 'PWD': '/builds/slave/test', 01:35:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:12 INFO - 'SHELL': '/bin/bash', 01:35:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:12 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:12 INFO - 'USER': 'cltbld', 01:35:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:12 INFO - 'XPC_FLAGS': '0x0', 01:35:12 INFO - 'XPC_SERVICE_NAME': '0', 01:35:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:12 INFO - Downloading/unpacking jsonschema 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:35:15 INFO - Downloading/unpacking functools32 (from jsonschema) 01:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:35:15 INFO - Downloading functools32-3.2.3-2.tar.gz 01:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:35:16 INFO - warning: no files found matching '*.txt' 01:35:16 INFO - no previously-included directories found matching 'build' 01:35:16 INFO - no previously-included directories found matching 'dist' 01:35:16 INFO - no previously-included directories found matching '.git*' 01:35:16 INFO - Installing collected packages: jsonschema, functools32 01:35:16 INFO - Running setup.py install for functools32 01:35:16 INFO - warning: no files found matching '*.txt' 01:35:16 INFO - no previously-included directories found matching 'build' 01:35:16 INFO - no previously-included directories found matching 'dist' 01:35:16 INFO - no previously-included directories found matching '.git*' 01:35:16 INFO - Successfully installed jsonschema functools32 01:35:16 INFO - Cleaning up... 01:35:16 INFO - Return code: 0 01:35:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10487ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1048854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5da49c0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, '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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 01:35: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', 'flake8'] in /builds/slave/test/build 01:35: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 flake8 01:35:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:16 INFO - 'HOME': '/Users/cltbld', 01:35:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:16 INFO - 'LOGNAME': 'cltbld', 01:35:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:16 INFO - 'MOZ_NO_REMOTE': '1', 01:35:16 INFO - 'NO_EM_RESTART': '1', 01:35:16 INFO - 'PAGER': '/bin/cat', 01:35:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:16 INFO - 'PWD': '/builds/slave/test', 01:35:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:16 INFO - 'SHELL': '/bin/bash', 01:35:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:16 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:16 INFO - 'USER': 'cltbld', 01:35:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:16 INFO - 'XPC_FLAGS': '0x0', 01:35:16 INFO - 'XPC_SERVICE_NAME': '0', 01:35:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:16 INFO - Downloading/unpacking flake8 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:35:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:35:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35: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 01:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:35:20 INFO - no previously-included directories found matching 'docs/_build' 01:35:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:35:20 INFO - Running setup.py install for pep8 01:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:35:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:35:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:35:20 INFO - no previously-included directories found matching 'docs/_build' 01:35:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:35:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:35:20 INFO - Cleaning up... 01:35:20 INFO - Return code: 0 01:35:20 INFO - Running post-action listener: _resource_record_post_action 01:35:20 INFO - Running post-action listener: _start_resource_monitoring 01:35:20 INFO - Starting resource monitoring. 01:35:20 INFO - ##### 01:35:20 INFO - ##### Running install step. 01:35:20 INFO - ##### 01:35:20 INFO - Running pre-action listener: _resource_record_pre_action 01:35:20 INFO - Running main action method: install 01:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:35:20 INFO - Reading from file tmpfile_stdout 01:35:20 INFO - Detecting whether we're running mozinstall >=1.0... 01:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:35:20 INFO - Reading from file tmpfile_stdout 01:35:20 INFO - Output received: 01:35:20 INFO - Usage: mozinstall [options] installer 01:35:20 INFO - Options: 01:35:20 INFO - -h, --help show this help message and exit 01:35:20 INFO - -d DEST, --destination=DEST 01:35:20 INFO - Directory to install application into. [default: 01:35:20 INFO - "/builds/slave/test"] 01:35:20 INFO - --app=APP Application being installed. [default: firefox] 01:35:20 INFO - mkdir: /builds/slave/test/build/application 01:35:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:35:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:35:54 INFO - Reading from file tmpfile_stdout 01:35:54 INFO - Output received: 01:35:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:35:54 INFO - Running post-action listener: _resource_record_post_action 01:35:54 INFO - ##### 01:35:54 INFO - ##### Running run-tests step. 01:35:54 INFO - ##### 01:35:54 INFO - Running pre-action listener: _resource_record_pre_action 01:35:54 INFO - Running main action method: run_tests 01:35:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:35:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:35:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:35:54 INFO - 2016-03-07 01:35:54.848 screenresolution[1646:7525] starting screenresolution argv=screenresolution get 01:35:54 INFO - 2016-03-07 01:35:54.851 screenresolution[1646:7525] Display 0: 1600x1200x32@60 01:35:54 INFO - 2016-03-07 01:35:54.857 screenresolution[1647:7527] starting screenresolution argv=screenresolution list 01:35:54 INFO - Available Modes on Display 0 01:35:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:35:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:35:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:35:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:35:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:35:55 INFO - Intel Iris: 01:35:55 INFO - Chipset Model: Intel Iris 01:35:55 INFO - Type: GPU 01:35:55 INFO - Bus: Built-In 01:35:55 INFO - VRAM (Dynamic, Max): 1536 MB 01:35:55 INFO - Vendor: Intel (0x8086) 01:35:55 INFO - Device ID: 0x0a2e 01:35:55 INFO - Revision ID: 0x0009 01:35:55 INFO - Displays: 01:35:55 INFO - Display: 01:35:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:35:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:35:55 INFO - Display Serial Number: 1600x1200 60 01:35:55 INFO - Main Display: Yes 01:35:55 INFO - Mirror: Off 01:35:55 INFO - Online: Yes 01:35:55 INFO - Rotation: Supported 01:35:55 INFO - Return code: 0 01:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:35:55 INFO - Python 2.7.3 01:35:55 INFO - Return code: 0 01:35:55 INFO - grabbing minidump binary from tooltool 01:35:55 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')]} 01:35:55 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 0x104722d30>, '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 0x104546db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104719b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:35:55 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 01:35:55 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 01:35:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:35:55 INFO - Return code: 0 01:35:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:35:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:35:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:35:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:35:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:35:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:35:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:35:56 INFO - Return code: 0 01:35:56 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/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 01:35:56 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/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --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 01:35:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.O9FwIWr6w0/Render', 01:35:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:35:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:35:56 INFO - 'HOME': '/Users/cltbld', 01:35:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:35:56 INFO - 'LOGNAME': 'cltbld', 01:35:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:35:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:35:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:56 INFO - 'MOZ_NO_REMOTE': '1', 01:35:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:35:56 INFO - 'NO_EM_RESTART': '1', 01:35:56 INFO - 'PAGER': '/bin/cat', 01:35:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:35:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:56 INFO - 'PWD': '/builds/slave/test', 01:35:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:35:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:35:56 INFO - 'SHELL': '/bin/bash', 01:35:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HLsuUSlbo1/Listeners', 01:35:56 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 01:35:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:35:56 INFO - 'USER': 'cltbld', 01:35:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:35:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:35:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:56 INFO - 'XPC_FLAGS': '0x0', 01:35:56 INFO - 'XPC_SERVICE_NAME': '0', 01:35:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:35:56 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/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--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 01:35:56 INFO - mozversion application_buildid: 20160307003410 01:35:56 INFO - mozversion application_changeset: 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d 01:35:56 INFO - mozversion application_display_name: Nightly 01:35:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:35:56 INFO - mozversion application_name: Firefox 01:35:56 INFO - mozversion application_remotingname: firefox 01:35:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:35:56 INFO - mozversion application_vendor: Mozilla 01:35:56 INFO - mozversion application_version: 47.0a1 01:35:56 INFO - mozversion platform_buildid: 20160307003410 01:35:56 INFO - mozversion platform_changeset: 5ee60bdfe6b8ec27522ee6dfaf43dc6d6ba99a1d 01:35:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:35:56 INFO - mozversion platform_version: 47.0a1 01:35:56 INFO - using testdate: 1457343356 01:35:56 INFO - actual date: 1457343356 01:35:56 INFO - starting webserver on 'localhost:49272' 01:35:56 INFO - SUITE-START | Running 2 tests 01:35:56 INFO - TEST-START | dromaeo_css 01:35:56 INFO - operating with platform_type : mac_ 01:35:56 INFO - Initialising browser for dromaeo_css test... 01:35:56 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpWugF7p/profile http://localhost:49272/getInfo.html) 01:35:59 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 01:35:59 INFO - PROCESS | 1665 | colorDepth:24 01:35:59 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 01:35:59 INFO - PROCESS | 1665 | __metrics 01:35:59 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:36:00 INFO - TEST-INFO | 1665: exit 0 01:36:00 INFO - Browser initialized. 01:36:00 INFO - Running cycle 1/1 for dromaeo_css test... 01:36:00 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpWugF7p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:36:12 INFO - PROCESS | 1669 | RSS: Main: 256409600 01:36:12 INFO - PROCESS | 1669 | 01:37:02 INFO - PROCESS | 1669 | 1457343422039 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] 01:39:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 01:39:14 INFO - PROCESS | 1669 | RSS: Main: 271618048 01:39:14 INFO - PROCESS | 1669 | 01:42:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 01:42:17 INFO - PROCESS | 1669 | RSS: Main: 283815936 01:42:17 INFO - PROCESS | 1669 | 01:45:19 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 01:45:19 INFO - PROCESS | 1669 | RSS: Main: 284606464 01:45:19 INFO - PROCESS | 1669 | 01:48:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 01:48:22 INFO - PROCESS | 1669 | RSS: Main: 286666752 01:48:22 INFO - PROCESS | 1669 | 01:51:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 01:51:25 INFO - PROCESS | 1669 | RSS: Main: 288645120 01:51:25 INFO - PROCESS | 1669 | 01:54:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 01:54:28 INFO - PROCESS | 1669 | RSS: Main: 291487744 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | __start_tp_report 01:54:28 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 01:54:28 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 01:54:28 INFO - PROCESS | 1669 | |i|pagename|runs| 01:54:28 INFO - PROCESS | 1669 | |0;dojo.html;3456.6197718250996;3471.6875481206694;3491.3540994915925;3510.315488479746;3557.982210088949;5114;5640.125780504023;5668.370058054356;5678.290213723285;5679.233303504026;5493.890122197554;5666.263385759846;5703.344115426717;5727.856803579913;5805.651660900349;5172.40517340506;5188.533032027117;5208.921866172011;5230.947690523084;5248.475152484759;5208.270842082112;5240.528352448279;5250.133727934905;5272.182811664179;5276.7889284428575;5132.28148059272;5132.332796736419;5192.532672059495;5207.297014903015;5213.661112027706;5162.690238585659;5191.143461328877;5195.298634684307;5204.141316682742;5248.950209958024;5040.7731652075745;5137.871553211162;5158.200478925773;5179.378474583036;5187.118189907725;5440.700761458118;5648.661080335193;5654.5193658538665;5673.914891276593;5695.373508914016;5377.542908852753;6256.937430625727;6259.780907668255;6266.060090986343;6277.183966084425;4523.932141017887;5646.350669672999;6108.493847774667;6146.78486252979;6244.406781355764;5810.82567522975;5815.185873977604;5825.563082768809;5851.444112809277;5889.823305300848;6275.717592708339;6282;6285.96857015712;6293.622382657055;6303.842403939847;5025.4974502550185;6002.339742628307;6097.4817140543555;6102.420270074336;6146.371211628922;6130.6628135452975;6143.32423433422;6255.343188965184;6298.748050077946;6300.243970723451;6168.321484636686;6174.135621013062;6230.875382492325;6242.719077641517;6248.28144763349;6090.116933044684;6140.258857967814;6145.539084568675;6272.278687950853;6299.905501417483;4883.413990321184;4905.411350637946;4908.41099068107;4913.263010548446;4931.5315045070665;3996.0609256824623;4379.671524635665;4385.276429389115;4393.780310984438;4414.735115893057;5548.528375088082;5646.124850648074;5743.885122297531;5763;5790.131480277992;6191.443197108321;6216.782412615627;6235.688215589203;6243.906341404882;6265.248170219603;5741.827745167651;5746.195532625436;5757.078867381283;5781.797637082682;5795.217645617872;5241.344831896013;5312.1766126250495;5362.624616276823;5373.328333958255;5401.3518377794135;6280.466160376328;6309.053641953652;6314.6842657866;6317.6209427434505;6413.102165696806;6095.7708482108;6233.949442918433;6294.590851594632;6300.558960872695;6303.495720342454;6241.470839644317;6260.561760676891;6295.401936815995;6303.36966303366;6315.684215789284;6130.601510901777;6163.537734669828;6167.5374346925055;6169.753209871735;6204.286507051746;6056.121862330026;6104.755809767737;6178.258608966953;6234.563580549318;6263.78076767311;5952.880942381042;6071.787487437919;6137.478314343331;6151.907721384094;6188.597741146811;5949.524038076857;6093.878122437615;6100.278413292402;6114.3414711855385;6122.743970213742;4278.080212754273;4891.608671306358;5932.733027013708;5966.671833049224;6007.48936340416;6105.755769769159;6130.141780150871;6134.171886795226;6171.938280617316;6185.319614842454;5991.071383935497;6014;6067.453929146398;6072.969635151972;6073.665948372882 01:54:28 INFO - PROCESS | 1669 | |1;ext.html;507.97206153661557;596.5466245653303;603.7102190948344;652.0447544347531;654.9934500654994;26685.866570667145;28293.43413131736;38622.61377386232;38846.223075538546;38913.44346226151;32236.710531578767;40001.19997600046;40036;40423.98940026494;40526;7572.507786993841;9701.563429645683;9704.951475242613;9714.65998690046;9727;8313.459625124378;9528.809423811519;9768.169705575036;9803.48046052863;9827.410355378664;8385.748427547183;9654.90345096547;9765.414075155513;9766.560504777302;9782.51087445625;9723.22214222864;9728.513574321327;9774.75563110928;9819.312648114636;9827.606895724162;9651.517424128766;9715.319927605071;9719.125278724878;9735.853962190573;9768.95115524425;32153.51769723456;39056;39447.21105577901;39517.012074698076;39537.604623953965;3183.0291761013114;3218.678132186786;3276.918077048069;3694.131879008431;3889.611038896116;28228.576571351445;28330.150095497167;28460.715392846014;28514;28652.570211446844;2687.140115163129;2745.6156138140677;2751.147144385227;2862.255813488487;2921.9269518262;408437;413139;415050;416944;508699;47807;73040.90438643425;73623.52752944911;73868;74077;48774;48780.5121948776;48861.77845553889;48974;49197.754011229714;15709.921450392674;15713.21433928299;15863.52409427719;15867.206639667971;15920.52238432849;12366.381680915918;12516.249025058525;12610.054245931591;12748.490060397666;12763.680907977376;13492.797608035888;14684.384717681047;15137.848621513644;15145.848541514664;15535.922320388325;5918.852028699231;6864.38220560152;7122.216556178816;7133.322334378226;7174;937.9906200937903;942.853857652065;973.1047436358567;1127.153241063424;1169.4445138559117;27483.725162748116;29800.850995744884;29986.250343741143;30227.395452091274;30373.39253214923;909.2498688581946;991.7173605522391;1163.2206421697483;1167.8131498960126;1179.967528412639;14509.766669832972;15017.624559386102;15068.472603458826;15156.848431515544;15535.611609709847;458698.4780913156;543133;543634;545333;545529;49289.75355123202;60814.391856080874;61067;61528.38471615316;61774.69112654498;1381.3645722967347;1423.9818529751071;1451.673373490956;1452.8401875793654;1473.0425223604743;24351.75648243495;28434.715652843206;28587.42825143527;29181.854090729412;29957.251068723457;52135.739321303154;52364.73817630888;52439.47560524499;52546.73726631495;52787.47212527979;413910;415504;415677;508538;508568;27489.72510274872;33909;34309.82845085759;34948.33042530498;35021.124471888405;37683.62316376801;45406;45824.08351833012;46234.07531849411;46242.53757462382;37897.4315385275;37969;38011;38569.807150964065;38728.6127138725;36819;37251;37531;37888.242235155696;37948.24103517969;31085.911993080135;36066.45900311445;36184.457233140995;36293;36537.90386288416;30814.69185308118;31096.378072438878;31395.37209255848;32470.350592987535;32613.673863261065;24450;24622.876885615457;24637.876810616548;24655.137070202458;24843.751562484144 01:54:28 INFO - PROCESS | 1669 | |2;jquery.html;317.9380020895925;353.8266249537726;359.71223021582733;368.1771241275749;371.2204370821274;19578.804211957875;19733.703994440093;20943.05756240969;20945.847978361224;20964.371068867957;20248.493787655316;20642.69035964458;20817.791822081774;20938;21320.4669883253;5186.740662966856;5751.993401154792;6075.210222671047;6076.118962750398;6078.787242446493;4264.23243816113;5951.702414879239;6280.214973128359;6524.184476940382;6552.475801935833;6433.806985790434;6477.287498375175;6482.708278127472;6492.740290388402;6493.448056915168;6400.487960963112;6575.671216439159;6576.76981305652;6596.241432235306;6616.106825578558;4941.901161976776;5622.128570071645;5658.660480371191;5668.716564171775;5699.943000569982;25146.87426562874;25349.366265843317;25468;26004;26678;1910.6083252933115;2072.678734796109;2208.381653137108;2381.940451488709;2863.9140825775053;9285.58214880332;9806.362586431931;9916.95041524795;9958.80082398348;10072.143867771249;1701.5065630967006;1708.2825213410397;1725.9741103883453;1744.2151032035636;1778.2975724588844;83722.58138709268;104872.47563762132;109836;110724.89275107226;110758.44620776924;9193.49435781025;11310.830337544943;11330.60342887995;11355.318680879009;11371.31772093677;13607.727845443036;13611.319434028457;13646.522371716943;13652.931735341259;13675.589732308046;8468.153184681605;8605.483670979636;8625.611847466878;8679.566021699016;8752.343574231958;6586.04502347157;8800.691975780817;8810.691625793195;8873.068327825486;8909.777255568533;3666.3400587894434;4353.368761529624;4458.710183838105;4470.038941627566;4471.642268618502;1751.745996830478;1822.1071674879213;1837.384476200461;1856.3688345962437;1857.3127942661301;884.9380543362032;978.3005151316843;1017.4505766885799;1025.1388833379847;1059.9099076578423;17535.73696394555;19657.508562286057;19785.60428791416;20565.897170514352;21038.474038148863;731.3125661877817;945.5839430650492;957.707899090784;970.6360114956891;1070.593174593665;8481.491110533389;11150.052245559056;11203.831942520868;11270.887291127148;11636.010939070275;612120;613433;615905;621267;635189;112531;121715;123157;123318;123667;1043.113353649392;1045.5660900726266;1071.1002757683427;1099.5766629847567;1101.8292164714483;18043.909780451013;18314.633707326044;18316.81683183151;18443.538911527317;18497.075146242365;51457.48542514677;51925;52125;52442.475575243756;52904.47095528995;52669.94660106853;71529.6423517879;76101.6194919044;76892.23107769074;77848.61075694585;8057.758267251757;8063.717769878026;8115.066767321598;8127.674893004214;8174.346052315919;11684.298942063504;11909.761804763682;13083.607491775261;13276.80084798748;13537.661558461117;10534.788499322676;11220;11440.94279528597;11729.35488548138;11786.823197651871;10222.948885255526;11248.156388270749;11327.433628318717;11433.828492572784;11439.370834604177;11685.415729213335;11853.051755859684;11937.820932685843;11958.402079896145;12000.759984800081;7942.602869856369;8092.959535202286;8099.433039687166;8144.389170812095;8238.093809680811;10522.526486307981;11634.53461861516;11822.763544728885;11841.230320029515;11907.285562866256 01:54:28 INFO - PROCESS | 1669 | |3;mootools.html;1565.6007718031901;1575.5037163293566;1876.1182244345162;1972.0337034852917;2019.5657933544285;7908.3673306135515;8517.574121293927;8902;9115.680951166702;9129.908700912998;8826.955865220665;8858.95570522148;8926.776830579238;8959.193672569467;8961.955190224056;2479.5040991801666;2489.6638953741194;2492.252324302711;2503.1864643990775;2504.8246622736415;2431.732509423962;2473.332200305916;2477.083479112731;2477.2072936660275;2488.129154795825;2474.393773525489;2488.042103790036;2508.811839112074;2525.8105642076916;2528.1783420388356;2052.158614967856;2087.7181580486667;2124.2034237161065;2456.7666071723156;2460.188137914493;2464.18681834994;2485.2792690119845;2497.2133777859917;2501.774840264385;2504.962425563618;7719.884201736979;8927.37508374414;8965.775855603597;9007.639694412215;9065.365424420293;5494.395616482184;5537.280153580049;5579.079451890433;5622;5627.493525582676;3624.8912532624063;3691.8154092295276;3752.3996160614442;3761.2477504498934;3767.792771397572;898.285862739124;1048.8479170520309;1067.2049323254148;1070.250824422907;1075.4945175767377;12193.512259509609;12320.81518777219;12356;12374.690632734164;12380.442880070419;4244.490661120685;4938.851834444972;4948.208286674115;5055.823046193365;5074.162763144113;10156.136728378171;10259.435731034864;10343.27597068198;10361.63734269297;10385.480725963671;5509.4765997231;5543.223948647193;5572.247746554163;5623.297087864017;5624.831255062355;4481.126180394857;4867.415910090741;4980.327655766425;5012.298278241049;5058.671186372874;3955.3869150281753;4032.5967403259438;4050.736702114353;4079.5920407958965;4091.468109145792;1316.8946484281234;1323.7021670124338;1329.8736620021082;1333.9399727012308;1338.7991801229698;1101.24014430043;1101.8402331661864;1103.6358001859367;1142.8685701144475;1314.0801438992744;7240.4569657275915;8188.672453101928;8245.257926786499;8315.916840831635;8321.167883211752;1152.0783373301326;1155.3876445483907;1175.7119505721153;1195.6293548999663;1228.3121451986915;6327.810165695037;6337.841553961096;6402.807915762534;6405.647689377129;6407.038944158414;10393.740156495996;10511.737206569896;10657;10714.142868570496;10816.296940698987;9655.17241379302;10146.492675366202;10519.631812886511;10575.995280448498;10663.680089597325;8450.450720703135;8577.485350878967;8588;8594;8689.478631282143;8085.393595480245;8222.465539739898;8320.167983201873;8353.498790072616;8405.285550728013;9655.758606034906;9661.323707340418;9847.950760246153;9873.555689994111;9891.357061791248;10023;10029.498525073572;10097.899021009696;10255.692329230134;10380.32527885685;6900.068490753684;7121.893171602534;7293.927060729325;7602.581857997642;7743.303102720783;7938.960305198437;7962.522248665098;7977.162397948132;8007.279344858991;8013;7076.115485564304;7203.315685009916;7251;7300.780976570712;7312.232215617283;7079.8938015930835;7108.0048793170035;7180.497365184596;7186.38915692172;7255.600941948243;7541.7360392386;7572.091349037931;7584.810379740551;7591.848163036819;7606.087269527692;6872.553284036721;6927.82680432973;6953.930460695531;6956.130483689539;6970.198427180736;5949.464548190684;6889.758858439931;6909.378155965987;7016.649167541705;7043.401310888632 01:54:28 INFO - PROCESS | 1669 | |4;prototype.html;311.7365825877134;316.1747838142449;333.28676632007495;336.13277743421975;339.95750531183586;6584.736610535585;6681.1314529111205;6729.394354508093;6749.493787965897;6757.087793147924;6615.636140012298;6632.071509988606;6654.467642588594;6763.458923286137;6769.966150169243;4701.811927522895;4776.426828780551;4911.926321105168;4931.2603109533675;5011.624128190382;4942.357493525855;4969.353983982095;4972.552470277675;4974.900501989958;4986.5761410280165;4913.901721965559;4924.901501969958;4938.604911607081;4939.950600493985;4953.083679519283;4930.482299358569;4938.135826230396;4944.258361245842;4945.35710357653;4963.60291176705;4225.767582782945;4234.364845273203;4235.894102647428;4236.830526778926;4250.553691862372;5169.431362550116;6210.099535567318;6318.43134117927;6407.103005579223;6466.094746735461;5805.53555715546;5853.326867410217;5857.736401861926;5861.267341582302;5889.263842019747;7104.43164546835;7110.822229444254;7115.786526404165;7135.750248741269;7166.820829479253;4731.101090792738;4743.881402964919;4755.358026666425;4760.690555113906;4762.523747625244;7528.849423011564;7539.811504712426;7543.811404714871;7554;7575.810604734871;4561.703489273186;4615.169269531517;4692.272697731857;4750.311204875274;4787.61699064074;4848.200046992278;4853.0779151961015;4859.441164266154;4881.560659540658;4883.853484395474;5635.802746903839;5689.374168841424;5700.945325114867;5702.716888700009;5732.34078081026;7006.194287656985;7062.964685176541;7128.607926564089;7139.500234983501;7153.7138514459875;1603.7273663477238;1659.2616285752724;1697.6842946716395;1705.1644694099803;1725.568607848038;1109.6171820721838;1113.1873732175395;1126.864776226858;1129.373197875187;1131.2590253384046;4695.403562788668;5591.804286849941;6575.375339342755;6603.7688680895935;6608.702608382634;7358.816029599303;7364.410847132323;7373.77878663641;7374.33630973215;7422.814429639194;5312.442193569619;6569.540132190797;6594.208694956636;6607.075009498674;6621.635810030494;3783.659470647655;3879.0108522326627;3924.6664033557468;3932.5477570079806;3935.6064393560414;7500.399968002655;7570.432217583703;7688.231176882267;7697.4226932980255;7750.844983100419;7622.618869056636;7625.6949722010495;7643.541387516656;7659.655315510815;7743.574103424366;7776.144624091346;7798.805029874298;7808.258215469635;7813.843723125619;7829.804254893673;7191.2449192834;7456.589887556236;7486.588237646982;7492.887606685795;7527.623618818928;5817.7963771267805;5936.525077993837;7343.70625174987;7346.742863999734;7362.190159082389;6827.931720682928;7748.690052397841;7757.495762775401;7775.883361749465;7796.688132474637;4760.619150468024;4760.714357138583;4774.809007639656;4779.187538118597;4784.138855006132;5862.325832529144;6528.836779080561;6619.470442364695;7405.444591655755;7463.955046293415;7153.4277257820295;7184.856302874018;7187.065681461586;7198.49610527258;7248.202697703354;7162;7181.317774811385;7184.275773814352;7185.958036084843;7199.424046076406;7023.086998690138;7025.964870175617;7034.753783617549;7052.894206586802;7057.258987806412;6917.619530925847;7139.607321597362;7149.53528020677;7168.390686791473;7175.712971481291;6948.826279343057;6952.860942781217;7002.354446704919;7016.298370162943;7034 01:54:28 INFO - PROCESS | 1669 | |5;yui.html;700.8668353012927;718.809515478398;728.9830686192761;759.3962799574338;794.6106407860146;14793;14949.626259343522;15004.324805383756;15041.473548425807;15060.246987650615;13936.790948135786;13974.301284935738;13974.650633734162;14001.719965600681;14011.439542418317;873.0527377795084;937.0488953711988;938.6902322233681;939.8872135343734;941.7880976780203;747.977560673178;883.5228976352762;940.4733349324366;940.5062342270329;941.0213378086816;981.4847205217246;981.9558119884587;982.9115379615833;983.5475681186663;984.7242772023844;961.8364877970691;974.2400927276735;975.5609975511048;978.2027647467291;979.8971108033661;710.1761956130863;721.203070606977;724.0298000679115;727.8034930568717;729.5768454296496;15303.846961530353;15553.22233888301;15590.298436570381;15732.44936427231;15764.842351576566;12567.937160314232;12568.560100396442;12597.244165350017;12788.48846046157;12890.097693161482;10103.898961010369;10115.393076415365;10172.389656620626;10236.846447303296;11103.611373601885;3486.1110416843794;3588.2105936694147;3604.5494313210847;3683.834227459771;3703.981480092609;83914.58042709809;84537;84653;85326;86296;9282.48946307946;9445.338826282094;9464.216653609996;9642.987486313976;9661;21429.892850535958;21502.677459838116;21546.03042863075;21563.568728625338;21673.566528669653;6101.725422356005;7306.086739157606;7441.255874412515;7604.467687261838;7611.314981651678;4005.959940400617;4069.5726948669962;4072.552019277877;4073.7148399612333;4115.444415003936;3566.5363502744476;3587.031501494582;3606.02637287936;3608.260306637133;3623.166671665479;650.3983814971227;673.239239659182;678.0439580191905;695.7043256615918;696.0220889649949;512.2290952117114;523.6465385864526;582.1239035251918;602.7432802606614;611.1138848669447;8246.09292977772;8256.1331060239;8295.460795048302;8410;8442.45124066946;526.602415176547;554.7337278106531;577.6591810831629;608.818891350778;611.119987218404;3853.5183102112237;3857.479240302523;3864.652181303696;3935.7244992850797;3973.0861901762178;86285;86581;90293;91627;91683;74139.62930185314;75199;76149;76229;78844;67970.32029679739;67989.64020719657;68205;68235;69187;7738.922610774045;7750.99237099196;7923.3661307096445;8018.719344822904;8032.036155661358;35052.64947350494;46063.539364605924;47641;49046.509534904195;51035.74482127566;54487;60140;64034;64515.67742161259;76679;11095.778084438105;11110.888891111308;11367.602133925273;11379.487923043649;11691.240069395462;12070.215435996632;12082.154249202824;12095.57665481739;12256.080793940311;12377.504899803907;11466.484008219484;11549.595764148215;11555.306681599131;12021.939890300493;12046.156769026084;11395.820966993615;11736.237144585575;11796.115291353355;12063.698407539881;12205.267683938991;9337;9950.35322704022;10695.786084278116;11903.761924761284;12263;9492.525373731423;9566.66516671913;9596.088371604686;9606.66376676813;9965.35225210359;8730.17063378978;9811.460369679737;9842.75393115178;9861;9952 01:54:28 INFO - PROCESS | 1669 | __end_tp_report 01:54:28 INFO - PROCESS | 1669 | __start_cc_report 01:54:28 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,369 01:54:28 INFO - PROCESS | 1669 | __end_cc_report 01:54:28 INFO - PROCESS | 1669 | __startTimestamp1457344468178__endTimestamp 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | ------- Summary: start ------- 01:54:28 INFO - PROCESS | 1669 | Number of tests: 6 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5697.24 Median:5949.52 stddev:653.04 (11.0%) stddev-sans-first:630.95 01:54:28 INFO - PROCESS | 1669 | Values: 3456.6 3471.7 3491.4 3510.3 3558.0 5114.0 5640.1 5668.4 5678.3 5679.2 5493.9 5666.3 5703.3 5727.9 5805.7 5172.4 5188.5 5208.9 5230.9 5248.5 5208.3 5240.5 5250.1 5272.2 5276.8 5132.3 5132.3 5192.5 5207.3 5213.7 5162.7 5191.1 5195.3 5204.1 5249.0 5040.8 5137.9 5158.2 5179.4 5187.1 5440.7 5648.7 5654.5 5673.9 5695.4 5377.5 6256.9 6259.8 6266.1 6277.2 4523.9 5646.4 6108.5 6146.8 6244.4 5810.8 5815.2 5825.6 5851.4 5889.8 6275.7 6282.0 6286.0 6293.6 6303.8 5025.5 6002.3 6097.5 6102.4 6146.4 6130.7 6143.3 6255.3 6298.7 6300.2 6168.3 6174.1 6230.9 6242.7 6248.3 6090.1 6140.3 6145.5 6272.3 6299.9 4883.4 4905.4 4908.4 4913.3 4931.5 3996.1 4379.7 4385.3 4393.8 4414.7 5548.5 5646.1 5743.9 5763.0 5790.1 6191.4 6216.8 6235.7 6243.9 6265.2 5741.8 5746.2 5757.1 5781.8 5795.2 5241.3 5312.2 5362.6 5373.3 5401.4 6280.5 6309.1 6314.7 6317.6 6413.1 6095.8 6233.9 6294.6 6300.6 6303.5 6241.5 6260.6 6295.4 6303.4 6315.7 6130.6 6163.5 6167.5 6169.8 6204.3 6056.1 6104.8 6178.3 6234.6 6263.8 5952.9 6071.8 6137.5 6151.9 6188.6 5949.5 6093.9 6100.3 6114.3 6122.7 4278.1 4891.6 5932.7 5966.7 6007.5 6105.8 6130.1 6134.2 6171.9 6185.3 5991.1 6014.0 6067.5 6073.0 6073.7 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:61271.74 Median:21367.92 stddev:126133.48 (590.3%) stddev-sans-first:126404.81 01:54:28 INFO - PROCESS | 1669 | Values: 508.0 596.5 603.7 652.0 655.0 26685.9 28293.4 38622.6 38846.2 38913.4 32236.7 40001.2 40036.0 40424.0 40526.0 7572.5 9701.6 9705.0 9714.7 9727.0 8313.5 9528.8 9768.2 9803.5 9827.4 8385.7 9654.9 9765.4 9766.6 9782.5 9723.2 9728.5 9774.8 9819.3 9827.6 9651.5 9715.3 9719.1 9735.9 9769.0 32153.5 39056.0 39447.2 39517.0 39537.6 3183.0 3218.7 3276.9 3694.1 3889.6 28228.6 28330.2 28460.7 28514.0 28652.6 2687.1 2745.6 2751.1 2862.3 2921.9 408437.0 413139.0 415050.0 416944.0 508699.0 47807.0 73040.9 73623.5 73868.0 74077.0 48774.0 48780.5 48861.8 48974.0 49197.8 15709.9 15713.2 15863.5 15867.2 15920.5 12366.4 12516.2 12610.1 12748.5 12763.7 13492.8 14684.4 15137.8 15145.8 15535.9 5918.9 6864.4 7122.2 7133.3 7174.0 938.0 942.9 973.1 1127.2 1169.4 27483.7 29800.9 29986.3 30227.4 30373.4 909.2 991.7 1163.2 1167.8 1180.0 14509.8 15017.6 15068.5 15156.8 15535.6 458698.5 543133.0 543634.0 545333.0 545529.0 49289.8 60814.4 61067.0 61528.4 61774.7 1381.4 1424.0 1451.7 1452.8 1473.0 24351.8 28434.7 28587.4 29181.9 29957.3 52135.7 52364.7 52439.5 52546.7 52787.5 413910.0 415504.0 415677.0 508538.0 508568.0 27489.7 33909.0 34309.8 34948.3 35021.1 37683.6 45406.0 45824.1 46234.1 46242.5 37897.4 37969.0 38011.0 38569.8 38728.6 36819.0 37251.0 37531.0 37888.2 37948.2 31085.9 36066.5 36184.5 36293.0 36537.9 30814.7 31096.4 31395.4 32470.4 32613.7 24450.0 24622.9 24637.9 24655.1 24843.8 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34815.16 Median:13764.41 stddev:102709.56 (746.2%) stddev-sans-first:102965.02 01:54:28 INFO - PROCESS | 1669 | Values: 317.9 353.8 359.7 368.2 371.2 19578.8 19733.7 20943.1 20945.8 20964.4 20248.5 20642.7 20817.8 20938.0 21320.5 5186.7 5752.0 6075.2 6076.1 6078.8 4264.2 5951.7 6280.2 6524.2 6552.5 6433.8 6477.3 6482.7 6492.7 6493.4 6400.5 6575.7 6576.8 6596.2 6616.1 4941.9 5622.1 5658.7 5668.7 5699.9 25146.9 25349.4 25468.0 26004.0 26678.0 1910.6 2072.7 2208.4 2381.9 2863.9 9285.6 9806.4 9917.0 9958.8 10072.1 1701.5 1708.3 1726.0 1744.2 1778.3 83722.6 104872.5 109836.0 110724.9 110758.4 9193.5 11310.8 11330.6 11355.3 11371.3 13607.7 13611.3 13646.5 13652.9 13675.6 8468.2 8605.5 8625.6 8679.6 8752.3 6586.0 8800.7 8810.7 8873.1 8909.8 3666.3 4353.4 4458.7 4470.0 4471.6 1751.7 1822.1 1837.4 1856.4 1857.3 884.9 978.3 1017.5 1025.1 1059.9 17535.7 19657.5 19785.6 20565.9 21038.5 731.3 945.6 957.7 970.6 1070.6 8481.5 11150.1 11203.8 11270.9 11636.0 612120.0 613433.0 615905.0 621267.0 635189.0 112531.0 121715.0 123157.0 123318.0 123667.0 1043.1 1045.6 1071.1 1099.6 1101.8 18043.9 18314.6 18316.8 18443.5 18497.1 51457.5 51925.0 52125.0 52442.5 52904.5 52669.9 71529.6 76101.6 76892.2 77848.6 8057.8 8063.7 8115.1 8127.7 8174.3 11684.3 11909.8 13083.6 13276.8 13537.7 10534.8 11220.0 11440.9 11729.4 11786.8 10222.9 11248.2 11327.4 11433.8 11439.4 11685.4 11853.1 11937.8 11958.4 12000.8 7942.6 8093.0 8099.4 8144.4 8238.1 10522.5 11634.5 11822.8 11841.2 11907.3 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6096.31 Median:5057.25 stddev:3212.30 (63.5%) stddev-sans-first:3203.26 01:54:28 INFO - PROCESS | 1669 | Values: 1565.6 1575.5 1876.1 1972.0 2019.6 7908.4 8517.6 8902.0 9115.7 9129.9 8827.0 8859.0 8926.8 8959.2 8962.0 2479.5 2489.7 2492.3 2503.2 2504.8 2431.7 2473.3 2477.1 2477.2 2488.1 2474.4 2488.0 2508.8 2525.8 2528.2 2052.2 2087.7 2124.2 2456.8 2460.2 2464.2 2485.3 2497.2 2501.8 2505.0 7719.9 8927.4 8965.8 9007.6 9065.4 5494.4 5537.3 5579.1 5622.0 5627.5 3624.9 3691.8 3752.4 3761.2 3767.8 898.3 1048.8 1067.2 1070.3 1075.5 12193.5 12320.8 12356.0 12374.7 12380.4 4244.5 4938.9 4948.2 5055.8 5074.2 10156.1 10259.4 10343.3 10361.6 10385.5 5509.5 5543.2 5572.2 5623.3 5624.8 4481.1 4867.4 4980.3 5012.3 5058.7 3955.4 4032.6 4050.7 4079.6 4091.5 1316.9 1323.7 1329.9 1333.9 1338.8 1101.2 1101.8 1103.6 1142.9 1314.1 7240.5 8188.7 8245.3 8315.9 8321.2 1152.1 1155.4 1175.7 1195.6 1228.3 6327.8 6337.8 6402.8 6405.6 6407.0 10393.7 10511.7 10657.0 10714.1 10816.3 9655.2 10146.5 10519.6 10576.0 10663.7 8450.5 8577.5 8588.0 8594.0 8689.5 8085.4 8222.5 8320.2 8353.5 8405.3 9655.8 9661.3 9848.0 9873.6 9891.4 10023.0 10029.5 10097.9 10255.7 10380.3 6900.1 7121.9 7293.9 7602.6 7743.3 7939.0 7962.5 7977.2 8007.3 8013.0 7076.1 7203.3 7251.0 7300.8 7312.2 7079.9 7108.0 7180.5 7186.4 7255.6 7541.7 7572.1 7584.8 7591.8 7606.1 6872.6 6927.8 6953.9 6956.1 6970.2 5949.5 6889.8 6909.4 7016.6 7043.4 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5826.86 Median:6598.99 stddev:1850.11 (28.0%) stddev-sans-first:1808.40 01:54:28 INFO - PROCESS | 1669 | Values: 311.7 316.2 333.3 336.1 340.0 6584.7 6681.1 6729.4 6749.5 6757.1 6615.6 6632.1 6654.5 6763.5 6770.0 4701.8 4776.4 4911.9 4931.3 5011.6 4942.4 4969.4 4972.6 4974.9 4986.6 4913.9 4924.9 4938.6 4940.0 4953.1 4930.5 4938.1 4944.3 4945.4 4963.6 4225.8 4234.4 4235.9 4236.8 4250.6 5169.4 6210.1 6318.4 6407.1 6466.1 5805.5 5853.3 5857.7 5861.3 5889.3 7104.4 7110.8 7115.8 7135.8 7166.8 4731.1 4743.9 4755.4 4760.7 4762.5 7528.8 7539.8 7543.8 7554.0 7575.8 4561.7 4615.2 4692.3 4750.3 4787.6 4848.2 4853.1 4859.4 4881.6 4883.9 5635.8 5689.4 5700.9 5702.7 5732.3 7006.2 7063.0 7128.6 7139.5 7153.7 1603.7 1659.3 1697.7 1705.2 1725.6 1109.6 1113.2 1126.9 1129.4 1131.3 4695.4 5591.8 6575.4 6603.8 6608.7 7358.8 7364.4 7373.8 7374.3 7422.8 5312.4 6569.5 6594.2 6607.1 6621.6 3783.7 3879.0 3924.7 3932.5 3935.6 7500.4 7570.4 7688.2 7697.4 7750.8 7622.6 7625.7 7643.5 7659.7 7743.6 7776.1 7798.8 7808.3 7813.8 7829.8 7191.2 7456.6 7486.6 7492.9 7527.6 5817.8 5936.5 7343.7 7346.7 7362.2 6827.9 7748.7 7757.5 7775.9 7796.7 4760.6 4760.7 4774.8 4779.2 4784.1 5862.3 6528.8 6619.5 7405.4 7464.0 7153.4 7184.9 7187.1 7198.5 7248.2 7162.0 7181.3 7184.3 7186.0 7199.4 7023.1 7026.0 7034.8 7052.9 7057.3 6917.6 7139.6 7149.5 7168.4 7175.7 6948.8 6952.9 7002.4 7016.3 7034.0 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18052.06 Median:32322.56 stddev:25230.97 (78.1%) stddev-sans-first:25268.11 01:54:28 INFO - PROCESS | 1669 | Values: 700.9 718.8 729.0 759.4 794.6 14793.0 14949.6 15004.3 15041.5 15060.2 13936.8 13974.3 13974.7 14001.7 14011.4 873.1 937.0 938.7 939.9 941.8 748.0 883.5 940.5 940.5 941.0 981.5 982.0 982.9 983.5 984.7 961.8 974.2 975.6 978.2 979.9 710.2 721.2 724.0 727.8 729.6 15303.8 15553.2 15590.3 15732.4 15764.8 12567.9 12568.6 12597.2 12788.5 12890.1 10103.9 10115.4 10172.4 10236.8 11103.6 3486.1 3588.2 3604.5 3683.8 3704.0 83914.6 84537.0 84653.0 85326.0 86296.0 9282.5 9445.3 9464.2 9643.0 9661.0 21429.9 21502.7 21546.0 21563.6 21673.6 6101.7 7306.1 7441.3 7604.5 7611.3 4006.0 4069.6 4072.6 4073.7 4115.4 3566.5 3587.0 3606.0 3608.3 3623.2 650.4 673.2 678.0 695.7 696.0 512.2 523.6 582.1 602.7 611.1 8246.1 8256.1 8295.5 8410.0 8442.5 526.6 554.7 577.7 608.8 611.1 3853.5 3857.5 3864.7 3935.7 3973.1 86285.0 86581.0 90293.0 91627.0 91683.0 74139.6 75199.0 76149.0 76229.0 78844.0 67970.3 67989.6 68205.0 68235.0 69187.0 7738.9 7751.0 7923.4 8018.7 8032.0 35052.6 46063.5 47641.0 49046.5 51035.7 54487.0 60140.0 64034.0 64515.7 76679.0 11095.8 11110.9 11367.6 11379.5 11691.2 12070.2 12082.2 12095.6 12256.1 12377.5 11466.5 11549.6 11555.3 12021.9 12046.2 11395.8 11736.2 11796.1 12063.7 12205.3 9337.0 9950.4 10695.8 11903.8 12263.0 9492.5 9566.7 9596.1 9606.7 9965.4 8730.2 9811.5 9842.8 9861.0 9952.0 01:54:28 INFO - PROCESS | 1669 | -------- Summary: end -------- 01:54:28 INFO - PROCESS | 1669 | 01:54:28 INFO - TEST-INFO | 1669: exit 0 01:54:28 INFO - TEST-OK | dromaeo_css | took 1112090ms 01:54:28 INFO - TEST-START | kraken 01:54:28 INFO - operating with platform_type : mac_ 01:54:28 INFO - Initialising browser for kraken test... 01:54:28 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxbSeb0/profile http://localhost:49272/getInfo.html) 01:54:31 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 01:54:31 INFO - PROCESS | 1680 | colorDepth:24 01:54:31 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 01:54:31 INFO - PROCESS | 1680 | __metrics 01:54:31 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:54:32 INFO - TEST-INFO | 1680: exit 0 01:54:32 INFO - Browser initialized. 01:54:32 INFO - Running cycle 1/1 for kraken test... 01:54:32 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpxbSeb0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:54:44 INFO - PROCESS | 1683 | RSS: Main: 256376832 01:54:44 INFO - PROCESS | 1683 | 01:54:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 01:54:47 INFO - PROCESS | 1683 | RSS: Main: 268853248 01:54:47 INFO - PROCESS | 1683 | 01:54:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 01:54:50 INFO - PROCESS | 1683 | RSS: Main: 276844544 01:54:50 INFO - PROCESS | 1683 | 01:54:54 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 01:54:54 INFO - PROCESS | 1683 | RSS: Main: 278757376 01:54:54 INFO - PROCESS | 1683 | 01:54:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 01:54:57 INFO - PROCESS | 1683 | RSS: Main: 280776704 01:54:57 INFO - PROCESS | 1683 | 01:54:59 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:54:59 INFO - PROCESS | 1683 | RSS: Main: 281841664 01:54:59 INFO - PROCESS | 1683 | 01:55:02 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 01:55:03 INFO - PROCESS | 1683 | RSS: Main: 283230208 01:55:03 INFO - PROCESS | 1683 | 01:55:06 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 01:55:06 INFO - PROCESS | 1683 | RSS: Main: 282025984 01:55:06 INFO - PROCESS | 1683 | 01:55:09 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 01:55:10 INFO - PROCESS | 1683 | RSS: Main: 283357184 01:55:10 INFO - PROCESS | 1683 | 01:55:11 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:55:12 INFO - PROCESS | 1683 | RSS: Main: 281563136 01:55:12 INFO - PROCESS | 1683 | 01:55:14 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:55:15 INFO - PROCESS | 1683 | RSS: Main: 282361856 01:55:15 INFO - PROCESS | 1683 | 01:55:17 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:55:17 INFO - PROCESS | 1683 | RSS: Main: 282513408 01:55:17 INFO - PROCESS | 1683 | 01:55:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:55:20 INFO - PROCESS | 1683 | RSS: Main: 283783168 01:55:20 INFO - PROCESS | 1683 | 01:55:23 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:55:24 INFO - PROCESS | 1683 | RSS: Main: 282525696 01:55:24 INFO - PROCESS | 1683 | 01:55:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 01:55:26 INFO - PROCESS | 1683 | RSS: Main: 284045312 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | __start_tp_report 01:55:26 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 01:55:26 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 01:55:26 INFO - PROCESS | 1683 | |i|pagename|runs| 01:55:26 INFO - PROCESS | 1683 | |0;ai-astar;114;108;114;115;110;125;116;112;114;112 01:55:26 INFO - PROCESS | 1683 | |1;audio-beat-detection;149;122;141;154;122;139;108;183;184;150 01:55:26 INFO - PROCESS | 1683 | |2;audio-dft;193;200;196;197;202;228;200;198;198;201 01:55:26 INFO - PROCESS | 1683 | |3;audio-fft;63;66;66;83;86;63;76;114;62;73 01:55:26 INFO - PROCESS | 1683 | |4;audio-oscillator;76;81;118;77;82;78;117;79;80;115 01:55:26 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;89;92;91;87;90;88;92;90;90;86 01:55:26 INFO - PROCESS | 1683 | |6;imaging-darkroom;113;151;116;96;95;103;97;105;139;150 01:55:26 INFO - PROCESS | 1683 | |7;imaging-desaturate;93;94;91;126;149;147;94;91;93;95 01:55:26 INFO - PROCESS | 1683 | |8;json-parse-financial;57;57;56;57;55;57;56;64;59;57 01:55:26 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;66;70;75;69;77;77;73;68;68;79 01:55:26 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;86;88;85;86;84;85;84;89;88;84 01:55:26 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;123;131;123;125;114;114;139;140;138;124 01:55:26 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;139;143;139;140;164;183;151;140;146;132 01:55:26 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;65;68;66;68;68;68;69;70;67;69 01:55:26 INFO - PROCESS | 1683 | __end_tp_report 01:55:26 INFO - PROCESS | 1683 | __start_cc_report 01:55:26 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,958 01:55:26 INFO - PROCESS | 1683 | __end_cc_report 01:55:26 INFO - PROCESS | 1683 | __startTimestamp1457344526010__endTimestamp 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | ------- Summary: start ------- 01:55:26 INFO - PROCESS | 1683 | Number of tests: 14 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:4.55 (4.0%) stddev-sans-first:4.82 01:55:26 INFO - PROCESS | 1683 | Values: 114.0 108.0 114.0 115.0 110.0 125.0 116.0 112.0 114.0 112.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.50 stddev:24.87 (16.6%) stddev-sans-first:26.34 01:55:26 INFO - PROCESS | 1683 | Values: 149.0 122.0 141.0 154.0 122.0 139.0 108.0 183.0 184.0 150.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:201.30 Median:200.00 stddev:9.74 (4.9%) stddev-sans-first:9.86 01:55:26 INFO - PROCESS | 1683 | Values: 193.0 200.0 196.0 197.0 202.0 228.0 200.0 198.0 198.0 201.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:75.20 Median:69.50 stddev:16.09 (23.1%) stddev-sans-first:16.45 01:55:26 INFO - PROCESS | 1683 | Values: 63.0 66.0 66.0 83.0 86.0 63.0 76.0 114.0 62.0 73.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:78.50 stddev:18.29 (23.3%) stddev-sans-first:18.66 01:55:26 INFO - PROCESS | 1683 | Values: 76.0 81.0 118.0 77.0 82.0 78.0 117.0 79.0 80.0 115.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:90.00 stddev:2.01 (2.2%) stddev-sans-first:2.13 01:55:26 INFO - PROCESS | 1683 | Values: 89.0 92.0 91.0 87.0 90.0 88.0 92.0 90.0 90.0 86.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:150.50 stddev:22.13 (14.7%) stddev-sans-first:23.44 01:55:26 INFO - PROCESS | 1683 | Values: 113.0 151.0 116.0 96.0 95.0 103.0 97.0 105.0 139.0 150.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:93.00 stddev:23.83 (25.6%) stddev-sans-first:24.71 01:55:26 INFO - PROCESS | 1683 | Values: 93.0 94.0 91.0 126.0 149.0 147.0 94.0 91.0 93.0 95.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:2.51 (4.4%) stddev-sans-first:2.65 01:55:26 INFO - PROCESS | 1683 | Values: 57.0 57.0 56.0 57.0 55.0 57.0 56.0 64.0 59.0 57.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:74.00 stddev:4.59 (6.2%) stddev-sans-first:4.28 01:55:26 INFO - PROCESS | 1683 | Values: 66.0 70.0 75.0 69.0 77.0 77.0 73.0 68.0 68.0 79.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.85 (2.2%) stddev-sans-first:1.96 01:55:26 INFO - PROCESS | 1683 | Values: 86.0 88.0 85.0 86.0 84.0 85.0 84.0 89.0 88.0 84.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:128.00 stddev:9.62 (7.5%) stddev-sans-first:10.09 01:55:26 INFO - PROCESS | 1683 | Values: 123.0 131.0 123.0 125.0 114.0 114.0 139.0 140.0 138.0 124.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:144.50 stddev:15.14 (10.5%) stddev-sans-first:15.73 01:55:26 INFO - PROCESS | 1683 | Values: 139.0 143.0 139.0 140.0 164.0 183.0 151.0 140.0 146.0 132.0 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.00 stddev:1.48 (2.2%) stddev-sans-first:1.17 01:55:26 INFO - PROCESS | 1683 | Values: 65.0 68.0 66.0 68.0 68.0 68.0 69.0 70.0 67.0 69.0 01:55:26 INFO - PROCESS | 1683 | -------- Summary: end -------- 01:55:26 INFO - PROCESS | 1683 | 01:55:26 INFO - TEST-INFO | 1683: exit 0 01:55:26 INFO - TEST-OK | kraken | took 58070ms 01:55:26 INFO - SUITE-END | took 1170s 01:55:27 INFO - Completed test suite (00:19:30) 01:55:27 INFO - javascript benchmark 01:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3456.6197718250996, 3471.6875481206694, 3491.3540994915925, 3510.315488479746, 3557.982210088949, 5114.0, 5640.125780504023, 5668.370058054356, 5678.290213723285, 5679.233303504026, 5493.890122197554, 5666.263385759846, 5703.344115426717, 5727.856803579913, 5805.651660900349, 5172.40517340506, 5188.533032027117, 5208.921866172011, 5230.947690523084, 5248.475152484759, 5208.270842082112, 5240.528352448279, 5250.133727934905, 5272.182811664179, 5276.7889284428575, 5132.28148059272, 5132.332796736419, 5192.532672059495, 5207.297014903015, 5213.661112027706, 5162.690238585659, 5191.143461328877, 5195.298634684307, 5204.141316682742, 5248.950209958024, 5040.7731652075745, 5137.871553211162, 5158.200478925773, 5179.378474583036, 5187.118189907725, 5440.700761458118, 5648.661080335193, 5654.5193658538665, 5673.914891276593, 5695.373508914016, 5377.542908852753, 6256.937430625727, 6259.780907668255, 6266.060090986343, 6277.183966084425, 4523.932141017887, 5646.350669672999, 6108.493847774667, 6146.78486252979, 6244.406781355764, 5810.82567522975, 5815.185873977604, 5825.563082768809, 5851.444112809277, 5889.823305300848, 6275.717592708339, 6282.0, 6285.96857015712, 6293.622382657055, 6303.842403939847, 5025.4974502550185, 6002.339742628307, 6097.4817140543555, 6102.420270074336, 6146.371211628922, 6130.6628135452975, 6143.32423433422, 6255.343188965184, 6298.748050077946, 6300.243970723451, 6168.321484636686, 6174.135621013062, 6230.875382492325, 6242.719077641517, 6248.28144763349, 6090.116933044684, 6140.258857967814, 6145.539084568675, 6272.278687950853, 6299.905501417483, 4883.413990321184, 4905.411350637946, 4908.41099068107, 4913.263010548446, 4931.5315045070665, 3996.0609256824623, 4379.671524635665, 4385.276429389115, 4393.780310984438, 4414.735115893057, 5548.528375088082, 5646.124850648074, 5743.885122297531, 5763.0, 5790.131480277992, 6191.443197108321, 6216.782412615627, 6235.688215589203, 6243.906341404882, 6265.248170219603, 5741.827745167651, 5746.195532625436, 5757.078867381283, 5781.797637082682, 5795.217645617872, 5241.344831896013, 5312.1766126250495, 5362.624616276823, 5373.328333958255, 5401.3518377794135, 6280.466160376328, 6309.053641953652, 6314.6842657866, 6317.6209427434505, 6413.102165696806, 6095.7708482108, 6233.949442918433, 6294.590851594632, 6300.558960872695, 6303.495720342454, 6241.470839644317, 6260.561760676891, 6295.401936815995, 6303.36966303366, 6315.684215789284, 6130.601510901777, 6163.537734669828, 6167.5374346925055, 6169.753209871735, 6204.286507051746, 6056.121862330026, 6104.755809767737, 6178.258608966953, 6234.563580549318, 6263.78076767311, 5952.880942381042, 6071.787487437919, 6137.478314343331, 6151.907721384094, 6188.597741146811, 5949.524038076857, 6093.878122437615, 6100.278413292402, 6114.3414711855385, 6122.743970213742, 4278.080212754273, 4891.608671306358, 5932.733027013708, 5966.671833049224, 6007.48936340416, 6105.755769769159, 6130.141780150871, 6134.171886795226, 6171.938280617316, 6185.319614842454, 5991.071383935497, 6014.0, 6067.453929146398, 6072.969635151972, 6073.665948372882], "unit": "score", "name": "dojo.html", "value": 5658.252560922197}, {"lowerIsBetter": false, "replicates": [507.97206153661557, 596.5466245653303, 603.7102190948344, 652.0447544347531, 654.9934500654994, 26685.866570667145, 28293.43413131736, 38622.61377386232, 38846.223075538546, 38913.44346226151, 32236.710531578767, 40001.19997600046, 40036.0, 40423.98940026494, 40526.0, 7572.507786993841, 9701.563429645683, 9704.951475242613, 9714.65998690046, 9727.0, 8313.459625124378, 9528.809423811519, 9768.169705575036, 9803.48046052863, 9827.410355378664, 8385.748427547183, 9654.90345096547, 9765.414075155513, 9766.560504777302, 9782.51087445625, 9723.22214222864, 9728.513574321327, 9774.75563110928, 9819.312648114636, 9827.606895724162, 9651.517424128766, 9715.319927605071, 9719.125278724878, 9735.853962190573, 9768.95115524425, 32153.51769723456, 39056.0, 39447.21105577901, 39517.012074698076, 39537.604623953965, 3183.0291761013114, 3218.678132186786, 3276.918077048069, 3694.131879008431, 3889.611038896116, 28228.576571351445, 28330.150095497167, 28460.715392846014, 28514.0, 28652.570211446844, 2687.140115163129, 2745.6156138140677, 2751.147144385227, 2862.255813488487, 2921.9269518262, 408437.0, 413139.0, 415050.0, 416944.0, 508699.0, 47807.0, 73040.90438643425, 73623.52752944911, 73868.0, 74077.0, 48774.0, 48780.5121948776, 48861.77845553889, 48974.0, 49197.754011229714, 15709.921450392674, 15713.21433928299, 15863.52409427719, 15867.206639667971, 15920.52238432849, 12366.381680915918, 12516.249025058525, 12610.054245931591, 12748.490060397666, 12763.680907977376, 13492.797608035888, 14684.384717681047, 15137.848621513644, 15145.848541514664, 15535.922320388325, 5918.852028699231, 6864.38220560152, 7122.216556178816, 7133.322334378226, 7174.0, 937.9906200937903, 942.853857652065, 973.1047436358567, 1127.153241063424, 1169.4445138559117, 27483.725162748116, 29800.850995744884, 29986.250343741143, 30227.395452091274, 30373.39253214923, 909.2498688581946, 991.7173605522391, 1163.2206421697483, 1167.8131498960126, 1179.967528412639, 14509.766669832972, 15017.624559386102, 15068.472603458826, 15156.848431515544, 15535.611609709847, 458698.4780913156, 543133.0, 543634.0, 545333.0, 545529.0, 49289.75355123202, 60814.391856080874, 61067.0, 61528.38471615316, 61774.69112654498, 1381.3645722967347, 1423.9818529751071, 1451.673373490956, 1452.8401875793654, 1473.0425223604743, 24351.75648243495, 28434.715652843206, 28587.42825143527, 29181.854090729412, 29957.251068723457, 52135.739321303154, 52364.73817630888, 52439.47560524499, 52546.73726631495, 52787.47212527979, 413910.0, 415504.0, 415677.0, 508538.0, 508568.0, 27489.72510274872, 33909.0, 34309.82845085759, 34948.33042530498, 35021.124471888405, 37683.62316376801, 45406.0, 45824.08351833012, 46234.07531849411, 46242.53757462382, 37897.4315385275, 37969.0, 38011.0, 38569.807150964065, 38728.6127138725, 36819.0, 37251.0, 37531.0, 37888.242235155696, 37948.24103517969, 31085.911993080135, 36066.45900311445, 36184.457233140995, 36293.0, 36537.90386288416, 30814.69185308118, 31096.378072438878, 31395.37209255848, 32470.350592987535, 32613.673863261065, 24450.0, 24622.876885615457, 24637.876810616548, 24655.137070202458, 24843.751562484144], "unit": "score", "name": "ext.html", "value": 19221.590615279772}, {"lowerIsBetter": false, "replicates": [317.9380020895925, 353.8266249537726, 359.71223021582733, 368.1771241275749, 371.2204370821274, 19578.804211957875, 19733.703994440093, 20943.05756240969, 20945.847978361224, 20964.371068867957, 20248.493787655316, 20642.69035964458, 20817.791822081774, 20938.0, 21320.4669883253, 5186.740662966856, 5751.993401154792, 6075.210222671047, 6076.118962750398, 6078.787242446493, 4264.23243816113, 5951.702414879239, 6280.214973128359, 6524.184476940382, 6552.475801935833, 6433.806985790434, 6477.287498375175, 6482.708278127472, 6492.740290388402, 6493.448056915168, 6400.487960963112, 6575.671216439159, 6576.76981305652, 6596.241432235306, 6616.106825578558, 4941.901161976776, 5622.128570071645, 5658.660480371191, 5668.716564171775, 5699.943000569982, 25146.87426562874, 25349.366265843317, 25468.0, 26004.0, 26678.0, 1910.6083252933115, 2072.678734796109, 2208.381653137108, 2381.940451488709, 2863.9140825775053, 9285.58214880332, 9806.362586431931, 9916.95041524795, 9958.80082398348, 10072.143867771249, 1701.5065630967006, 1708.2825213410397, 1725.9741103883453, 1744.2151032035636, 1778.2975724588844, 83722.58138709268, 104872.47563762132, 109836.0, 110724.89275107226, 110758.44620776924, 9193.49435781025, 11310.830337544943, 11330.60342887995, 11355.318680879009, 11371.31772093677, 13607.727845443036, 13611.319434028457, 13646.522371716943, 13652.931735341259, 13675.589732308046, 8468.153184681605, 8605.483670979636, 8625.611847466878, 8679.566021699016, 8752.343574231958, 6586.04502347157, 8800.691975780817, 8810.691625793195, 8873.068327825486, 8909.777255568533, 3666.3400587894434, 4353.368761529624, 4458.710183838105, 4470.038941627566, 4471.642268618502, 1751.745996830478, 1822.1071674879213, 1837.384476200461, 1856.3688345962437, 1857.3127942661301, 884.9380543362032, 978.3005151316843, 1017.4505766885799, 1025.1388833379847, 1059.9099076578423, 17535.73696394555, 19657.508562286057, 19785.60428791416, 20565.897170514352, 21038.474038148863, 731.3125661877817, 945.5839430650492, 957.707899090784, 970.6360114956891, 1070.593174593665, 8481.491110533389, 11150.052245559056, 11203.831942520868, 11270.887291127148, 11636.010939070275, 612120.0, 613433.0, 615905.0, 621267.0, 635189.0, 112531.0, 121715.0, 123157.0, 123318.0, 123667.0, 1043.113353649392, 1045.5660900726266, 1071.1002757683427, 1099.5766629847567, 1101.8292164714483, 18043.909780451013, 18314.633707326044, 18316.81683183151, 18443.538911527317, 18497.075146242365, 51457.48542514677, 51925.0, 52125.0, 52442.475575243756, 52904.47095528995, 52669.94660106853, 71529.6423517879, 76101.6194919044, 76892.23107769074, 77848.61075694585, 8057.758267251757, 8063.717769878026, 8115.066767321598, 8127.674893004214, 8174.346052315919, 11684.298942063504, 11909.761804763682, 13083.607491775261, 13276.80084798748, 13537.661558461117, 10534.788499322676, 11220.0, 11440.94279528597, 11729.35488548138, 11786.823197651871, 10222.948885255526, 11248.156388270749, 11327.433628318717, 11433.828492572784, 11439.370834604177, 11685.415729213335, 11853.051755859684, 11937.820932685843, 11958.402079896145, 12000.759984800081, 7942.602869856369, 8092.959535202286, 8099.433039687166, 8144.389170812095, 8238.093809680811, 10522.526486307981, 11634.53461861516, 11822.763544728885, 11841.230320029515, 11907.285562866256], "unit": "score", "name": "jquery.html", "value": 9513.86110994401}, {"lowerIsBetter": false, "replicates": [1565.6007718031901, 1575.5037163293566, 1876.1182244345162, 1972.0337034852917, 2019.5657933544285, 7908.3673306135515, 8517.574121293927, 8902.0, 9115.680951166702, 9129.908700912998, 8826.955865220665, 8858.95570522148, 8926.776830579238, 8959.193672569467, 8961.955190224056, 2479.5040991801666, 2489.6638953741194, 2492.252324302711, 2503.1864643990775, 2504.8246622736415, 2431.732509423962, 2473.332200305916, 2477.083479112731, 2477.2072936660275, 2488.129154795825, 2474.393773525489, 2488.042103790036, 2508.811839112074, 2525.8105642076916, 2528.1783420388356, 2052.158614967856, 2087.7181580486667, 2124.2034237161065, 2456.7666071723156, 2460.188137914493, 2464.18681834994, 2485.2792690119845, 2497.2133777859917, 2501.774840264385, 2504.962425563618, 7719.884201736979, 8927.37508374414, 8965.775855603597, 9007.639694412215, 9065.365424420293, 5494.395616482184, 5537.280153580049, 5579.079451890433, 5622.0, 5627.493525582676, 3624.8912532624063, 3691.8154092295276, 3752.3996160614442, 3761.2477504498934, 3767.792771397572, 898.285862739124, 1048.8479170520309, 1067.2049323254148, 1070.250824422907, 1075.4945175767377, 12193.512259509609, 12320.81518777219, 12356.0, 12374.690632734164, 12380.442880070419, 4244.490661120685, 4938.851834444972, 4948.208286674115, 5055.823046193365, 5074.162763144113, 10156.136728378171, 10259.435731034864, 10343.27597068198, 10361.63734269297, 10385.480725963671, 5509.4765997231, 5543.223948647193, 5572.247746554163, 5623.297087864017, 5624.831255062355, 4481.126180394857, 4867.415910090741, 4980.327655766425, 5012.298278241049, 5058.671186372874, 3955.3869150281753, 4032.5967403259438, 4050.736702114353, 4079.5920407958965, 4091.468109145792, 1316.8946484281234, 1323.7021670124338, 1329.8736620021082, 1333.9399727012308, 1338.7991801229698, 1101.24014430043, 1101.8402331661864, 1103.6358001859367, 1142.8685701144475, 1314.0801438992744, 7240.4569657275915, 8188.672453101928, 8245.257926786499, 8315.916840831635, 8321.167883211752, 1152.0783373301326, 1155.3876445483907, 1175.7119505721153, 1195.6293548999663, 1228.3121451986915, 6327.810165695037, 6337.841553961096, 6402.807915762534, 6405.647689377129, 6407.038944158414, 10393.740156495996, 10511.737206569896, 10657.0, 10714.142868570496, 10816.296940698987, 9655.17241379302, 10146.492675366202, 10519.631812886511, 10575.995280448498, 10663.680089597325, 8450.450720703135, 8577.485350878967, 8588.0, 8594.0, 8689.478631282143, 8085.393595480245, 8222.465539739898, 8320.167983201873, 8353.498790072616, 8405.285550728013, 9655.758606034906, 9661.323707340418, 9847.950760246153, 9873.555689994111, 9891.357061791248, 10023.0, 10029.498525073572, 10097.899021009696, 10255.692329230134, 10380.32527885685, 6900.068490753684, 7121.893171602534, 7293.927060729325, 7602.581857997642, 7743.303102720783, 7938.960305198437, 7962.522248665098, 7977.162397948132, 8007.279344858991, 8013.0, 7076.115485564304, 7203.315685009916, 7251.0, 7300.780976570712, 7312.232215617283, 7079.8938015930835, 7108.0048793170035, 7180.497365184596, 7186.38915692172, 7255.600941948243, 7541.7360392386, 7572.091349037931, 7584.810379740551, 7591.848163036819, 7606.087269527692, 6872.553284036721, 6927.82680432973, 6953.930460695531, 6956.130483689539, 6970.198427180736, 5949.464548190684, 6889.758858439931, 6909.378155965987, 7016.649167541705, 7043.401310888632], "unit": "score", "name": "mootools.html", "value": 4971.064893022311}, {"lowerIsBetter": false, "replicates": [311.7365825877134, 316.1747838142449, 333.28676632007495, 336.13277743421975, 339.95750531183586, 6584.736610535585, 6681.1314529111205, 6729.394354508093, 6749.493787965897, 6757.087793147924, 6615.636140012298, 6632.071509988606, 6654.467642588594, 6763.458923286137, 6769.966150169243, 4701.811927522895, 4776.426828780551, 4911.926321105168, 4931.2603109533675, 5011.624128190382, 4942.357493525855, 4969.353983982095, 4972.552470277675, 4974.900501989958, 4986.5761410280165, 4913.901721965559, 4924.901501969958, 4938.604911607081, 4939.950600493985, 4953.083679519283, 4930.482299358569, 4938.135826230396, 4944.258361245842, 4945.35710357653, 4963.60291176705, 4225.767582782945, 4234.364845273203, 4235.894102647428, 4236.830526778926, 4250.553691862372, 5169.431362550116, 6210.099535567318, 6318.43134117927, 6407.103005579223, 6466.094746735461, 5805.53555715546, 5853.326867410217, 5857.736401861926, 5861.267341582302, 5889.263842019747, 7104.43164546835, 7110.822229444254, 7115.786526404165, 7135.750248741269, 7166.820829479253, 4731.101090792738, 4743.881402964919, 4755.358026666425, 4760.690555113906, 4762.523747625244, 7528.849423011564, 7539.811504712426, 7543.811404714871, 7554.0, 7575.810604734871, 4561.703489273186, 4615.169269531517, 4692.272697731857, 4750.311204875274, 4787.61699064074, 4848.200046992278, 4853.0779151961015, 4859.441164266154, 4881.560659540658, 4883.853484395474, 5635.802746903839, 5689.374168841424, 5700.945325114867, 5702.716888700009, 5732.34078081026, 7006.194287656985, 7062.964685176541, 7128.607926564089, 7139.500234983501, 7153.7138514459875, 1603.7273663477238, 1659.2616285752724, 1697.6842946716395, 1705.1644694099803, 1725.568607848038, 1109.6171820721838, 1113.1873732175395, 1126.864776226858, 1129.373197875187, 1131.2590253384046, 4695.403562788668, 5591.804286849941, 6575.375339342755, 6603.7688680895935, 6608.702608382634, 7358.816029599303, 7364.410847132323, 7373.77878663641, 7374.33630973215, 7422.814429639194, 5312.442193569619, 6569.540132190797, 6594.208694956636, 6607.075009498674, 6621.635810030494, 3783.659470647655, 3879.0108522326627, 3924.6664033557468, 3932.5477570079806, 3935.6064393560414, 7500.399968002655, 7570.432217583703, 7688.231176882267, 7697.4226932980255, 7750.844983100419, 7622.618869056636, 7625.6949722010495, 7643.541387516656, 7659.655315510815, 7743.574103424366, 7776.144624091346, 7798.805029874298, 7808.258215469635, 7813.843723125619, 7829.804254893673, 7191.2449192834, 7456.589887556236, 7486.588237646982, 7492.887606685795, 7527.623618818928, 5817.7963771267805, 5936.525077993837, 7343.70625174987, 7346.742863999734, 7362.190159082389, 6827.931720682928, 7748.690052397841, 7757.495762775401, 7775.883361749465, 7796.688132474637, 4760.619150468024, 4760.714357138583, 4774.809007639656, 4779.187538118597, 4784.138855006132, 5862.325832529144, 6528.836779080561, 6619.470442364695, 7405.444591655755, 7463.955046293415, 7153.4277257820295, 7184.856302874018, 7187.065681461586, 7198.49610527258, 7248.202697703354, 7162.0, 7181.317774811385, 7184.275773814352, 7185.958036084843, 7199.424046076406, 7023.086998690138, 7025.964870175617, 7034.753783617549, 7052.894206586802, 7057.258987806412, 6917.619530925847, 7139.607321597362, 7149.53528020677, 7168.390686791473, 7175.712971481291, 6948.826279343057, 6952.860942781217, 7002.354446704919, 7016.298370162943, 7034.0], "unit": "score", "name": "prototype.html", "value": 5212.154263315103}, {"lowerIsBetter": false, "replicates": [700.8668353012927, 718.809515478398, 728.9830686192761, 759.3962799574338, 794.6106407860146, 14793.0, 14949.626259343522, 15004.324805383756, 15041.473548425807, 15060.246987650615, 13936.790948135786, 13974.301284935738, 13974.650633734162, 14001.719965600681, 14011.439542418317, 873.0527377795084, 937.0488953711988, 938.6902322233681, 939.8872135343734, 941.7880976780203, 747.977560673178, 883.5228976352762, 940.4733349324366, 940.5062342270329, 941.0213378086816, 981.4847205217246, 981.9558119884587, 982.9115379615833, 983.5475681186663, 984.7242772023844, 961.8364877970691, 974.2400927276735, 975.5609975511048, 978.2027647467291, 979.8971108033661, 710.1761956130863, 721.203070606977, 724.0298000679115, 727.8034930568717, 729.5768454296496, 15303.846961530353, 15553.22233888301, 15590.298436570381, 15732.44936427231, 15764.842351576566, 12567.937160314232, 12568.560100396442, 12597.244165350017, 12788.48846046157, 12890.097693161482, 10103.898961010369, 10115.393076415365, 10172.389656620626, 10236.846447303296, 11103.611373601885, 3486.1110416843794, 3588.2105936694147, 3604.5494313210847, 3683.834227459771, 3703.981480092609, 83914.58042709809, 84537.0, 84653.0, 85326.0, 86296.0, 9282.48946307946, 9445.338826282094, 9464.216653609996, 9642.987486313976, 9661.0, 21429.892850535958, 21502.677459838116, 21546.03042863075, 21563.568728625338, 21673.566528669653, 6101.725422356005, 7306.086739157606, 7441.255874412515, 7604.467687261838, 7611.314981651678, 4005.959940400617, 4069.5726948669962, 4072.552019277877, 4073.7148399612333, 4115.444415003936, 3566.5363502744476, 3587.031501494582, 3606.02637287936, 3608.260306637133, 3623.166671665479, 650.3983814971227, 673.239239659182, 678.0439580191905, 695.7043256615918, 696.0220889649949, 512.2290952117114, 523.6465385864526, 582.1239035251918, 602.7432802606614, 611.1138848669447, 8246.09292977772, 8256.1331060239, 8295.460795048302, 8410.0, 8442.45124066946, 526.602415176547, 554.7337278106531, 577.6591810831629, 608.818891350778, 611.119987218404, 3853.5183102112237, 3857.479240302523, 3864.652181303696, 3935.7244992850797, 3973.0861901762178, 86285.0, 86581.0, 90293.0, 91627.0, 91683.0, 74139.62930185314, 75199.0, 76149.0, 76229.0, 78844.0, 67970.32029679739, 67989.64020719657, 68205.0, 68235.0, 69187.0, 7738.922610774045, 7750.99237099196, 7923.3661307096445, 8018.719344822904, 8032.036155661358, 35052.64947350494, 46063.539364605924, 47641.0, 49046.509534904195, 51035.74482127566, 54487.0, 60140.0, 64034.0, 64515.67742161259, 76679.0, 11095.778084438105, 11110.888891111308, 11367.602133925273, 11379.487923043649, 11691.240069395462, 12070.215435996632, 12082.154249202824, 12095.57665481739, 12256.080793940311, 12377.504899803907, 11466.484008219484, 11549.595764148215, 11555.306681599131, 12021.939890300493, 12046.156769026084, 11395.820966993615, 11736.237144585575, 11796.115291353355, 12063.698407539881, 12205.267683938991, 9337.0, 9950.35322704022, 10695.786084278116, 11903.761924761284, 12263.0, 9492.525373731423, 9566.66516671913, 9596.088371604686, 9606.66376676813, 9965.35225210359, 8730.17063378978, 9811.460369679737, 9842.75393115178, 9861.0, 9952.0], "unit": "score", "name": "yui.html", "value": 6925.080573462811}], "name": "dromaeo_css", "value": 7553.10571775408}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 114.0, 115.0, 110.0, 125.0, 116.0, 112.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 114.0}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 141.0, 154.0, 122.0, 139.0, 108.0, 183.0, 184.0, 150.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [193.0, 200.0, 196.0, 197.0, 202.0, 228.0, 200.0, 198.0, 198.0, 201.0], "unit": "score", "name": "audio-dft", "value": 201.3}, {"lowerIsBetter": true, "replicates": [63.0, 66.0, 66.0, 83.0, 86.0, 63.0, 76.0, 114.0, 62.0, 73.0], "unit": "score", "name": "audio-fft", "value": 75.2}, {"lowerIsBetter": true, "replicates": [76.0, 81.0, 118.0, 77.0, 82.0, 78.0, 117.0, 79.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 90.3}, {"lowerIsBetter": true, "replicates": [89.0, 92.0, 91.0, 87.0, 90.0, 88.0, 92.0, 90.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.5}, {"lowerIsBetter": true, "replicates": [113.0, 151.0, 116.0, 96.0, 95.0, 103.0, 97.0, 105.0, 139.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 116.5}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 91.0, 126.0, 149.0, 147.0, 94.0, 91.0, 93.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 107.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 57.0, 55.0, 57.0, 56.0, 64.0, 59.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [66.0, 70.0, 75.0, 69.0, 77.0, 77.0, 73.0, 68.0, 68.0, 79.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 72.2}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 85.0, 86.0, 84.0, 85.0, 84.0, 89.0, 88.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [123.0, 131.0, 123.0, 125.0, 114.0, 114.0, 139.0, 140.0, 138.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [139.0, 143.0, 139.0, 140.0, 164.0, 183.0, 151.0, 140.0, 146.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 66.0, 68.0, 68.0, 68.0, 69.0, 70.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.8}], "name": "kraken", "value": 1497.5}]} 01:55:27 INFO - Return code: 0 01:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:55:27 ERROR - # TBPL SUCCESS # 01:55:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:55:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:55:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:55:27 INFO - 2016-03-07 01:55:27.307 screenresolution[1688:10523] starting screenresolution argv=screenresolution get 01:55:27 INFO - 2016-03-07 01:55:27.310 screenresolution[1688:10523] Display 0: 1600x1200x32@60 01:55:27 INFO - 2016-03-07 01:55:27.316 screenresolution[1689:10526] starting screenresolution argv=screenresolution list 01:55:27 INFO - Available Modes on Display 0 01:55:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:55:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:55:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:55:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:55:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:55:27 INFO - Intel Iris: 01:55:27 INFO - Chipset Model: Intel Iris 01:55:27 INFO - Type: GPU 01:55:27 INFO - Bus: Built-In 01:55:27 INFO - VRAM (Dynamic, Max): 1536 MB 01:55:27 INFO - Vendor: Intel (0x8086) 01:55:27 INFO - Device ID: 0x0a2e 01:55:27 INFO - Revision ID: 0x0009 01:55:27 INFO - Displays: 01:55:27 INFO - Display: 01:55:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:55:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:55:27 INFO - Display Serial Number: 1600x1200 60 01:55:27 INFO - Main Display: Yes 01:55:27 INFO - Mirror: Off 01:55:27 INFO - Online: Yes 01:55:27 INFO - Rotation: Supported 01:55:27 INFO - Return code: 0 01:55:27 INFO - Running post-action listener: _resource_record_post_action 01:55:27 INFO - Running post-run listener: _resource_record_post_run 01:55:28 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 39290368; Write bytes: 706536960; Read time: 424; Write time: 2008 01:55:28 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399077888; Write bytes: 392776704; Read time: 30350; Write time: 716 01:55:28 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37537280; Write bytes: 301054464; Read time: 406; Write time: 1255 01:55:28 INFO - Running post-run listener: _upload_blobber_files 01:55:28 INFO - Blob upload gear active. 01:55:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:55:28 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 01:55:28 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'] 01:55:28 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 01:55:29 INFO - (blobuploader) - INFO - Open directory for files ... 01:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:30 INFO - (blobuploader) - INFO - Done attempting. 01:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:55:31 INFO - (blobuploader) - INFO - Done attempting. 01:55:31 INFO - (blobuploader) - INFO - Iteration through files over. 01:55:31 INFO - Return code: 0 01:55:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:55:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:55:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705d7d05bf502bb639588ea2a278fef50bd510b9190ce126993fbaedbd54943ef4566a41c575a841a7ef465a91910a34f97087baed90fe76f34973e691c010e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b649039c3af30fc4d4e427578cd4ca37431f7d88b5bf4c625b3d7c792f12576761cdbef20ef44dfba39f59bdb1d926186fcee4ac34e804e5330f95a74168ed9"} 01:55:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:55:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:55:31 INFO - Contents: 01:55:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705d7d05bf502bb639588ea2a278fef50bd510b9190ce126993fbaedbd54943ef4566a41c575a841a7ef465a91910a34f97087baed90fe76f34973e691c010e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b649039c3af30fc4d4e427578cd4ca37431f7d88b5bf4c625b3d7c792f12576761cdbef20ef44dfba39f59bdb1d926186fcee4ac34e804e5330f95a74168ed9"} 01:55:31 INFO - Running post-run listener: copy_logs_to_upload_dir 01:55:31 INFO - Copying logs to upload dir... 01:55:31 INFO - mkdir: /builds/slave/test/build/upload/logs 01:55:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.638199 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-03-07 01:55:31.160145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 01:55:31.163667) ========= 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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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/705d7d05bf502bb639588ea2a278fef50bd510b9190ce126993fbaedbd54943ef4566a41c575a841a7ef465a91910a34f97087baed90fe76f34973e691c010e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b649039c3af30fc4d4e427578cd4ca37431f7d88b5bf4c625b3d7c792f12576761cdbef20ef44dfba39f59bdb1d926186fcee4ac34e804e5330f95a74168ed9"} build_url:https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010926 build_url: 'https://queue.taskcluster.net/v1/task/RZ1JVhmdSmy9dOvZ1Rb7-g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/705d7d05bf502bb639588ea2a278fef50bd510b9190ce126993fbaedbd54943ef4566a41c575a841a7ef465a91910a34f97087baed90fe76f34973e691c010e3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4b649039c3af30fc4d4e427578cd4ca37431f7d88b5bf4c625b3d7c792f12576761cdbef20ef44dfba39f59bdb1d926186fcee4ac34e804e5330f95a74168ed9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 01:55:31.191243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:55:31.191657) ========= 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.O9FwIWr6w0/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.HLsuUSlbo1/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005153 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 01:55:31.240114) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 01:55:31.240431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 01:55:31.240801) ========= ========= Total master_lag: 0.37 =========