builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1460386502.08 results: success (0) buildid: 20160411065021 builduid: 1b2fb46e10d94eb486a49d525ebe09a7 revision: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.077168) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.078161) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.078528) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005557 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.115155) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.115518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.199182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.199672) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005425 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.273421) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.273771) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.274184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.274513) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-11 07:55:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 25.8M=0s 2016-04-11 07:55:02 (25.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216823 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.518185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.518509) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.034036 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:02.592340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 07:55:02.592881) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --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 d93a1bc945137dfcc94866f1e30da1f55cfb8d9d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-11 07:55:02,672 truncating revision to first 12 chars 2016-04-11 07:55:02,672 Setting DEBUG logging. 2016-04-11 07:55:02,672 attempt 1/10 2016-04-11 07:55:02,673 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d93a1bc94513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-11 07:55:04,289 unpacking tar archive at: fx-team-d93a1bc94513/testing/mozharness/ program finished with exit code 0 elapsedTime=1.865289 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-11 07:55:04.485410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:04.485829) ========= echo d93a1bc945137dfcc94866f1e30da1f55cfb8d9d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 d93a1bc945137dfcc94866f1e30da1f55cfb8d9d program finished with exit code 0 elapsedTime=0.005580 script_repo_revision: 'd93a1bc945137dfcc94866f1e30da1f55cfb8d9d' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:04.549423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:04.549778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-11 07:55:04.593151) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-11 07:55:04.593707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:04 INFO - MultiFileLogger online at 20160411 07:55:04 in /builds/slave/test 07:55:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:55:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:55:04 INFO - {'append_to_log': False, 07:55:04 INFO - 'base_work_dir': '/builds/slave/test', 07:55:04 INFO - 'blob_upload_branch': 'Fx-Team', 07:55:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:55:04 INFO - 'branch': 'Fx-Team', 07:55:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:55:04 INFO - 'config_files': ('talos/mac_config.py',), 07:55:04 INFO - 'default_actions': ('clobber', 07:55:04 INFO - 'read-buildbot-config', 07:55:04 INFO - 'download-and-extract', 07:55:04 INFO - 'populate-webroot', 07:55:04 INFO - 'create-virtualenv', 07:55:04 INFO - 'install', 07:55:04 INFO - 'run-tests'), 07:55:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:55:04 INFO - 'download_minidump_stackwalk': True, 07:55:04 INFO - 'download_symbols': 'ondemand', 07:55:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:55:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:55:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:55:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:55:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:55:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:55:04 INFO - 'installer_path': 'installer.exe', 07:55:04 INFO - 'log_level': 'info', 07:55:04 INFO - 'log_name': 'talos', 07:55:04 INFO - 'log_to_console': True, 07:55:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:55:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:55:04 INFO - 'opt_config_files': (), 07:55:04 INFO - 'pip_index': False, 07:55:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:55:04 INFO - 'cmd': ('bash', 07:55:04 INFO - '-c', 07:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:55:04 INFO - 'enabled': True, 07:55:04 INFO - 'halt_on_failure': False, 07:55:04 INFO - 'name': 'check_screen_resolution'},), 07:55:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:55:04 INFO - 'cmd': ('bash', 07:55:04 INFO - '-c', 07:55:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:55:04 INFO - 'enabled': True, 07:55:04 INFO - 'halt_on_failure': False, 07:55:04 INFO - 'name': 'check_screen_resolution'},), 07:55:04 INFO - 'run_cmd_checks_enabled': True, 07:55:04 INFO - 'sps_profile': False, 07:55:04 INFO - 'sps_profile_interval': 0, 07:55:04 INFO - 'suite': 'dromaeojs', 07:55:04 INFO - 'system_bits': '32', 07:55:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:55:04 INFO - 'title': 't-yosemite-r7-0146', 07:55:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:55:04 INFO - 'use_talos_json': True, 07:55:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:55:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:55:04 INFO - 'work_dir': 'build'} 07:55:04 INFO - ##### 07:55:04 INFO - ##### Running clobber step. 07:55:04 INFO - ##### 07:55:04 INFO - Running pre-action listener: _resource_record_pre_action 07:55:04 INFO - Running main action method: clobber 07:55:04 INFO - rmtree: /builds/slave/test/build 07:55:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:55:06 INFO - Running post-action listener: _resource_record_post_action 07:55:06 INFO - ##### 07:55:06 INFO - ##### Running read-buildbot-config step. 07:55:06 INFO - ##### 07:55:06 INFO - Running pre-action listener: _resource_record_pre_action 07:55:06 INFO - Running main action method: read_buildbot_config 07:55:06 INFO - Using buildbot properties: 07:55:06 INFO - { 07:55:06 INFO - "project": "", 07:55:06 INFO - "product": "firefox", 07:55:06 INFO - "script_repo_revision": "production", 07:55:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:55:06 INFO - "repository": "", 07:55:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:55:06 INFO - "buildid": "20160411065021", 07:55:06 INFO - "pgo_build": "False", 07:55:06 INFO - "basedir": "/builds/slave/test", 07:55:06 INFO - "buildnumber": 653, 07:55:06 INFO - "slavename": "t-yosemite-r7-0146", 07:55:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:55:06 INFO - "platform": "yosemite_r7", 07:55:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:55:06 INFO - "branch": "fx-team", 07:55:06 INFO - "repo_path": "integration/fx-team", 07:55:06 INFO - "revision": "d93a1bc945137dfcc94866f1e30da1f55cfb8d9d", 07:55:06 INFO - "stage_platform": "macosx64", 07:55:06 INFO - "builduid": "1b2fb46e10d94eb486a49d525ebe09a7", 07:55:06 INFO - "slavebuilddir": "test" 07:55:06 INFO - } 07:55:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:55:06 INFO - Running post-action listener: _resource_record_post_action 07:55:06 INFO - ##### 07:55:06 INFO - ##### Running download-and-extract step. 07:55:06 INFO - ##### 07:55:06 INFO - Running pre-action listener: _resource_record_pre_action 07:55:06 INFO - Running main action method: download_and_extract 07:55:06 INFO - mkdir: /builds/slave/test/build/tests 07:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:55:06 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:55:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:55:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:55:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:55:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:55:08 INFO - Downloaded 1199 bytes. 07:55:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:55:08 INFO - Using the following test package requirements: 07:55:08 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:55:08 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:55:08 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:55:08 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'jsshell-mac.zip'], 07:55:08 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:55:08 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:55:08 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:55:08 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:55:08 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:55:08 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:55:08 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:55:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:55:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:08 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:55:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:55:11 INFO - Downloaded 18018734 bytes. 07:55:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:55:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:55:14 INFO - Return code: 0 07:55:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:14 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:55:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:55:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:55:18 INFO - Downloaded 18018734 bytes. 07:55:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:55:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:55:21 INFO - Return code: 0 07:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:21 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:55:22 INFO - Downloaded 10841046 bytes. 07:55:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:55:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:55:23 INFO - Return code: 0 07:55:23 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')]} 07:55:23 INFO - https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:55:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:55:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:55:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:55:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:55:38 INFO - Downloaded 108833223 bytes. 07:55:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:55:38 INFO - mkdir: /builds/slave/test/properties 07:55:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:55:38 INFO - Writing to file /builds/slave/test/properties/build_url 07:55:38 INFO - Contents: 07:55:38 INFO - build_url:https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - Running post-action listener: set_extra_try_arguments 07:55:39 INFO - ##### 07:55:39 INFO - ##### Running populate-webroot step. 07:55:39 INFO - ##### 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: populate_webroot 07:55:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:55:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:55:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:55:39 INFO - '--tppagecycles', 07:55:39 INFO - '7'], 07:55:39 INFO - 'tests': ['tsvgm']}}, 07:55:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:55:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:55:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:55:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:55:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:55:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['damp', 'tps']}, 07:55:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['damp', 'tps']}, 07:55:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['dromaeo_dom']}, 07:55:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:55:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'other-e10s': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['a11yr', 07:55:39 INFO - 'ts_paint', 07:55:39 INFO - 'tpaint', 07:55:39 INFO - 'sessionrestore', 07:55:39 INFO - 'sessionrestore_no_auto_restore', 07:55:39 INFO - 'tabpaint']}, 07:55:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['tsvgx', 07:55:39 INFO - 'tsvgr_opacity', 07:55:39 INFO - 'tart', 07:55:39 INFO - 'tscrollx', 07:55:39 INFO - 'cart']}, 07:55:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:55:39 INFO - 'tsvgr_opacity', 07:55:39 INFO - 'tart', 07:55:39 INFO - 'tscrollx', 07:55:39 INFO - 'cart']}, 07:55:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--disable-e10s'], 07:55:39 INFO - 'tests': ['tp5o']}, 07:55:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'tests': ['tp5o']}, 07:55:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--disable-e10s', 07:55:39 INFO - '--xperf_path', 07:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:39 INFO - 'tests': ['tp5n']}, 07:55:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:55:39 INFO - 'talos_options': ['--xperf_path', 07:55:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:55:39 INFO - 'tests': ['tp5n']}}, 07:55:39 INFO - 'talos.zip': {'path': '', 07:55:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:55:39 INFO - Running post-action listener: _resource_record_post_action 07:55:39 INFO - ##### 07:55:39 INFO - ##### Running create-virtualenv step. 07:55:39 INFO - ##### 07:55:39 INFO - Running pre-action listener: _resource_record_pre_action 07:55:39 INFO - Running main action method: create_virtualenv 07:55:39 INFO - Creating virtualenv /builds/slave/test/build/venv 07:55:39 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 07:55:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:55:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:55:39 INFO - Using real prefix '/tools/python27' 07:55:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:55:40 INFO - Installing distribute.............................................................................................................................................................................................done. 07:55:43 INFO - Installing pip.................done. 07:55:43 INFO - Return code: 0 07:55:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:55:43 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')]} 07:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:43 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')]} 07:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:43 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:43 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 07:55:43 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 07:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:43 INFO - 'HOME': '/Users/cltbld', 07:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:43 INFO - 'LOGNAME': 'cltbld', 07:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:43 INFO - 'MOZ_NO_REMOTE': '1', 07:55:43 INFO - 'NO_EM_RESTART': '1', 07:55:43 INFO - 'PAGER': '/bin/cat', 07:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:43 INFO - 'PWD': '/builds/slave/test', 07:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:43 INFO - 'SHELL': '/bin/bash', 07:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:55:43 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:43 INFO - 'USER': 'cltbld', 07:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:43 INFO - 'XPC_FLAGS': '0x0', 07:55:43 INFO - 'XPC_SERVICE_NAME': '0', 07:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:43 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 07:55:43 INFO - Cleaning up... 07:55:43 INFO - Return code: 0 07:55:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:55:43 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')]} 07:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:43 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')]} 07:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:43 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:43 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 07:55:43 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 07:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:43 INFO - 'HOME': '/Users/cltbld', 07:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:43 INFO - 'LOGNAME': 'cltbld', 07:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:43 INFO - 'MOZ_NO_REMOTE': '1', 07:55:43 INFO - 'NO_EM_RESTART': '1', 07:55:43 INFO - 'PAGER': '/bin/cat', 07:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:43 INFO - 'PWD': '/builds/slave/test', 07:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:43 INFO - 'SHELL': '/bin/bash', 07:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:55:43 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:43 INFO - 'USER': 'cltbld', 07:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:43 INFO - 'XPC_FLAGS': '0x0', 07:55:43 INFO - 'XPC_SERVICE_NAME': '0', 07:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:43 INFO - Downloading/unpacking psutil>=0.7.1 07:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:55:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:47 INFO - Installing collected packages: psutil 07:55:47 INFO - Running setup.py install for psutil 07:55:47 INFO - building 'psutil._psutil_osx' extension 07:55:47 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 07:55:47 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 07:55:47 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 07:55:47 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 07:55:48 INFO - building 'psutil._psutil_posix' extension 07:55:48 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 07:55:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:55:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:55:48 INFO - ^ 07:55:48 INFO - 1 warning generated. 07:55:48 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 07:55:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:55:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:55:48 INFO - Successfully installed psutil 07:55:48 INFO - Cleaning up... 07:55:48 INFO - Return code: 0 07:55:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:55:48 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')]} 07:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:48 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')]} 07:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:48 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:48 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 07:55:48 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 07:55:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:55:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:48 INFO - 'HOME': '/Users/cltbld', 07:55:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:48 INFO - 'LOGNAME': 'cltbld', 07:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:48 INFO - 'MOZ_NO_REMOTE': '1', 07:55:48 INFO - 'NO_EM_RESTART': '1', 07:55:48 INFO - 'PAGER': '/bin/cat', 07:55:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:48 INFO - 'PWD': '/builds/slave/test', 07:55:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:48 INFO - 'SHELL': '/bin/bash', 07:55:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:55:48 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:55:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:48 INFO - 'USER': 'cltbld', 07:55:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:48 INFO - 'XPC_FLAGS': '0x0', 07:55:48 INFO - 'XPC_SERVICE_NAME': '0', 07:55:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:55:48 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 07:55:48 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 07:55:48 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 07:55:48 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 07:55:48 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 07:55:48 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 07:55:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:55:51 INFO - Installing collected packages: mozsystemmonitor 07:55:51 INFO - Running setup.py install for mozsystemmonitor 07:55:51 INFO - Successfully installed mozsystemmonitor 07:55:51 INFO - Cleaning up... 07:55:51 INFO - Return code: 0 07:55:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:51 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:51 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 07:55:51 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 07:55:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:55:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:51 INFO - 'HOME': '/Users/cltbld', 07:55:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:51 INFO - 'LOGNAME': 'cltbld', 07:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:51 INFO - 'MOZ_NO_REMOTE': '1', 07:55:51 INFO - 'NO_EM_RESTART': '1', 07:55:51 INFO - 'PAGER': '/bin/cat', 07:55:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:51 INFO - 'PWD': '/builds/slave/test', 07:55:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:51 INFO - 'SHELL': '/bin/bash', 07:55:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:55:51 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:55:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:51 INFO - 'USER': 'cltbld', 07:55:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:51 INFO - 'XPC_FLAGS': '0x0', 07:55:51 INFO - 'XPC_SERVICE_NAME': '0', 07:55:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:51 INFO - Downloading/unpacking blobuploader==1.2.4 07:55:51 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 07:55:51 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 07:55:51 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 07:55:51 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 07:55:51 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 07:55:51 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 07:55:53 INFO - Downloading blobuploader-1.2.4.tar.gz 07:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:55:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:55:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:55:55 INFO - Downloading docopt-0.6.1.tar.gz 07:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:55:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:55:55 INFO - Running setup.py install for blobuploader 07:55:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:55:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:55:55 INFO - Running setup.py install for requests 07:55:55 INFO - Running setup.py install for docopt 07:55:55 INFO - Successfully installed blobuploader requests docopt 07:55:55 INFO - Cleaning up... 07:55:56 INFO - Return code: 0 07:55:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:55:56 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')]} 07:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:56 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')]} 07:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:55:56 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:55:56 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 07:55:56 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 07:55:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:55:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:55:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:55:56 INFO - 'HOME': '/Users/cltbld', 07:55:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:55:56 INFO - 'LOGNAME': 'cltbld', 07:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:55:56 INFO - 'MOZ_NO_REMOTE': '1', 07:55:56 INFO - 'NO_EM_RESTART': '1', 07:55:56 INFO - 'PAGER': '/bin/cat', 07:55:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:55:56 INFO - 'PWD': '/builds/slave/test', 07:55:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:55:56 INFO - 'SHELL': '/bin/bash', 07:55:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:55:56 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:55:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:55:56 INFO - 'USER': 'cltbld', 07:55:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:55:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:55:56 INFO - 'XPC_FLAGS': '0x0', 07:55:56 INFO - 'XPC_SERVICE_NAME': '0', 07:55:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-0PpSfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-QuC7sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-QETDN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ZF9Nhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qxVnMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5IqkMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:55:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:55:56 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-q43wM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WMdYvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Gp338b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-u_pi1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-h02cQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-36tzlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-s8CSu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-zOe_rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-bPFnjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:55:57 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-sVL3Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:55:58 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-xGSAYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:55:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:55:58 INFO - Running setup.py install for manifestparser 07:55:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:55:58 INFO - Running setup.py install for mozcrash 07:55:58 INFO - Running setup.py install for mozdebug 07:55:58 INFO - Running setup.py install for mozdevice 07:55:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:55:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:55:58 INFO - Running setup.py install for mozfile 07:55:58 INFO - Running setup.py install for mozhttpd 07:55:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:55:58 INFO - Running setup.py install for mozinfo 07:55:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Running setup.py install for mozInstall 07:55:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Running setup.py install for mozleak 07:55:59 INFO - Running setup.py install for mozlog 07:55:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Running setup.py install for moznetwork 07:55:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:55:59 INFO - Running setup.py install for mozprocess 07:55:59 INFO - Running setup.py install for mozprofile 07:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:56:00 INFO - Running setup.py install for mozrunner 07:56:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:56:00 INFO - Running setup.py install for mozscreenshot 07:56:00 INFO - Running setup.py install for moztest 07:56:00 INFO - Running setup.py install for mozversion 07:56:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:56:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:56:00 INFO - Cleaning up... 07:56:00 INFO - Return code: 0 07:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:00 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:56:00 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 07:56:00 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 07:56:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:56:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:00 INFO - 'HOME': '/Users/cltbld', 07:56:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:00 INFO - 'LOGNAME': 'cltbld', 07:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:00 INFO - 'MOZ_NO_REMOTE': '1', 07:56:00 INFO - 'NO_EM_RESTART': '1', 07:56:00 INFO - 'PAGER': '/bin/cat', 07:56:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:00 INFO - 'PWD': '/builds/slave/test', 07:56:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:00 INFO - 'SHELL': '/bin/bash', 07:56:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:56:00 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:56:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:00 INFO - 'USER': 'cltbld', 07:56:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:00 INFO - 'XPC_FLAGS': '0x0', 07:56:00 INFO - 'XPC_SERVICE_NAME': '0', 07:56:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:56:00 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WAcqb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-aUlIuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qFy1xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-gcDmVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-fSu8aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-miOrBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-m4ekI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-pJjStc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-1bCPUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-aCuvz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:56:01 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)) 07:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:56:01 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-F4chcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-xB5R8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-DY2Af9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-gh2Xwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-pUGR1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-4FT0Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:56:02 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)) 07:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:56:02 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-UZdY19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:56:02 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)) 07:56:02 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)) 07:56:02 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)) 07:56:02 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)) 07:56:02 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)) 07:56:02 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)) 07:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:02 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 07:56:05 INFO - Downloading blessings-1.6.tar.gz 07:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:56:05 INFO - Installing collected packages: blessings 07:56:05 INFO - Running setup.py install for blessings 07:56:05 INFO - Successfully installed blessings 07:56:05 INFO - Cleaning up... 07:56:05 INFO - Return code: 0 07:56:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:05 INFO - Reading from file tmpfile_stdout 07:56:05 INFO - Current package versions: 07:56:05 INFO - blessings == 1.6 07:56:05 INFO - blobuploader == 1.2.4 07:56:05 INFO - docopt == 0.6.1 07:56:05 INFO - manifestparser == 1.1 07:56:05 INFO - mozInstall == 1.12 07:56:05 INFO - mozcrash == 0.17 07:56:05 INFO - mozdebug == 0.1 07:56:05 INFO - mozdevice == 0.48 07:56:05 INFO - mozfile == 1.2 07:56:05 INFO - mozhttpd == 0.7 07:56:05 INFO - mozinfo == 0.9 07:56:05 INFO - mozleak == 0.1 07:56:05 INFO - mozlog == 3.1 07:56:05 INFO - moznetwork == 0.27 07:56:05 INFO - mozprocess == 0.22 07:56:05 INFO - mozprofile == 0.28 07:56:05 INFO - mozrunner == 6.11 07:56:05 INFO - mozscreenshot == 0.1 07:56:05 INFO - mozsystemmonitor == 0.0 07:56:05 INFO - moztest == 0.7 07:56:05 INFO - mozversion == 1.4 07:56:05 INFO - psutil == 3.1.1 07:56:05 INFO - requests == 1.2.3 07:56:05 INFO - wsgiref == 0.1.2 07:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:05 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:56:05 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 07:56:05 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 07:56:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:56:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:05 INFO - 'HOME': '/Users/cltbld', 07:56:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:05 INFO - 'LOGNAME': 'cltbld', 07:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:05 INFO - 'MOZ_NO_REMOTE': '1', 07:56:05 INFO - 'NO_EM_RESTART': '1', 07:56:05 INFO - 'PAGER': '/bin/cat', 07:56:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:05 INFO - 'PWD': '/builds/slave/test', 07:56:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:05 INFO - 'SHELL': '/bin/bash', 07:56:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:56:05 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:56:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:05 INFO - 'USER': 'cltbld', 07:56:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:05 INFO - 'XPC_FLAGS': '0x0', 07:56:05 INFO - 'XPC_SERVICE_NAME': '0', 07:56:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 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)) 07:56:06 INFO - Cleaning up... 07:56:06 INFO - Return code: 0 07:56:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:56:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:56:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:06 INFO - 'HOME': '/Users/cltbld', 07:56:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:06 INFO - 'LOGNAME': 'cltbld', 07:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:06 INFO - 'MOZ_NO_REMOTE': '1', 07:56:06 INFO - 'NO_EM_RESTART': '1', 07:56:06 INFO - 'PAGER': '/bin/cat', 07:56:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:06 INFO - 'PWD': '/builds/slave/test', 07:56:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:06 INFO - 'SHELL': '/bin/bash', 07:56:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:56:06 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:56:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:06 INFO - 'USER': 'cltbld', 07:56:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:06 INFO - 'XPC_FLAGS': '0x0', 07:56:06 INFO - 'XPC_SERVICE_NAME': '0', 07:56:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:06 INFO - Downloading/unpacking jsonschema 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:09 INFO - Downloading/unpacking functools32 (from jsonschema) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:09 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:09 INFO - warning: no files found matching '*.txt' 07:56:09 INFO - no previously-included directories found matching 'build' 07:56:09 INFO - no previously-included directories found matching 'dist' 07:56:09 INFO - no previously-included directories found matching '.git*' 07:56:09 INFO - Installing collected packages: jsonschema, functools32 07:56:09 INFO - Running setup.py install for functools32 07:56:09 INFO - warning: no files found matching '*.txt' 07:56:09 INFO - no previously-included directories found matching 'build' 07:56:09 INFO - no previously-included directories found matching 'dist' 07:56:09 INFO - no previously-included directories found matching '.git*' 07:56:09 INFO - Successfully installed jsonschema functools32 07:56:09 INFO - Cleaning up... 07:56:09 INFO - Return code: 0 07:56:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:10 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 0x10786ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10787e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcb63c9a7c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, '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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 07:56:10 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 07:56:10 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 07:56:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:56:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:10 INFO - 'HOME': '/Users/cltbld', 07:56:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:10 INFO - 'LOGNAME': 'cltbld', 07:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:10 INFO - 'MOZ_NO_REMOTE': '1', 07:56:10 INFO - 'NO_EM_RESTART': '1', 07:56:10 INFO - 'PAGER': '/bin/cat', 07:56:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:10 INFO - 'PWD': '/builds/slave/test', 07:56:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:10 INFO - 'SHELL': '/bin/bash', 07:56:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:56:10 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:56:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:10 INFO - 'USER': 'cltbld', 07:56:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:10 INFO - 'XPC_FLAGS': '0x0', 07:56:10 INFO - 'XPC_SERVICE_NAME': '0', 07:56:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:10 INFO - Downloading/unpacking flake8 07:56:10 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 07:56:10 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 07:56:10 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 07:56:10 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 07:56:10 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 07:56:10 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 07:56:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:56:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:56:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:14 INFO - no previously-included directories found matching 'docs/_build' 07:56:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:56:14 INFO - Running setup.py install for pep8 07:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:56:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:56:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:56:14 INFO - no previously-included directories found matching 'docs/_build' 07:56:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:56:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:56:14 INFO - Cleaning up... 07:56:14 INFO - Return code: 0 07:56:14 INFO - Running post-action listener: _resource_record_post_action 07:56:14 INFO - Running post-action listener: _start_resource_monitoring 07:56:14 INFO - Starting resource monitoring. 07:56:14 INFO - ##### 07:56:14 INFO - ##### Running install step. 07:56:14 INFO - ##### 07:56:14 INFO - Running pre-action listener: _resource_record_pre_action 07:56:14 INFO - Running main action method: install 07:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:56:14 INFO - Reading from file tmpfile_stdout 07:56:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:56:14 INFO - Reading from file tmpfile_stdout 07:56:14 INFO - Output received: 07:56:14 INFO - Usage: mozinstall [options] installer 07:56:14 INFO - Options: 07:56:14 INFO - -h, --help show this help message and exit 07:56:14 INFO - -d DEST, --destination=DEST 07:56:14 INFO - Directory to install application into. [default: 07:56:14 INFO - "/builds/slave/test"] 07:56:14 INFO - --app=APP Application being installed. [default: firefox] 07:56:14 INFO - mkdir: /builds/slave/test/build/application 07:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:56:47 INFO - Reading from file tmpfile_stdout 07:56:47 INFO - Output received: 07:56:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:56:47 INFO - Running post-action listener: _resource_record_post_action 07:56:47 INFO - ##### 07:56:47 INFO - ##### Running run-tests step. 07:56:47 INFO - ##### 07:56:47 INFO - Running pre-action listener: _resource_record_pre_action 07:56:47 INFO - Running main action method: run_tests 07:56:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:48 INFO - 2016-04-11 07:56:48.008 screenresolution[1659:8892] starting screenresolution argv=screenresolution get 07:56:48 INFO - 2016-04-11 07:56:48.011 screenresolution[1659:8892] Display 0: 1600x1200x32@60 07:56:48 INFO - 2016-04-11 07:56:48.016 screenresolution[1660:8894] starting screenresolution argv=screenresolution list 07:56:48 INFO - Available Modes on Display 0 07:56:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:48 INFO - Intel Iris: 07:56:48 INFO - Chipset Model: Intel Iris 07:56:48 INFO - Type: GPU 07:56:48 INFO - Bus: Built-In 07:56:48 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:48 INFO - Vendor: Intel (0x8086) 07:56:48 INFO - Device ID: 0x0a2e 07:56:48 INFO - Revision ID: 0x0009 07:56:48 INFO - Displays: 07:56:48 INFO - Display: 07:56:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:48 INFO - Display Serial Number: 1600x1200 60 07:56:48 INFO - Main Display: Yes 07:56:48 INFO - Mirror: Off 07:56:48 INFO - Online: Yes 07:56:48 INFO - Rotation: Supported 07:56:48 INFO - Return code: 0 07:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:56:48 INFO - Python 2.7.3 07:56:48 INFO - Return code: 0 07:56:48 INFO - grabbing minidump binary from tooltool 07:56:48 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')]} 07:56:48 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 0x10770de00>, '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 0x107536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107708b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:56:48 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 07:56:48 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 07:56:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:56:48 INFO - Return code: 0 07:56:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:56:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:56:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:56:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:56:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:56:49 INFO - Return code: 0 07:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8QDiRtOh6N/Render', 07:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:49 INFO - 'HOME': '/Users/cltbld', 07:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:49 INFO - 'LOGNAME': 'cltbld', 07:56:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:56:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:49 INFO - 'MOZ_NO_REMOTE': '1', 07:56:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:56:49 INFO - 'NO_EM_RESTART': '1', 07:56:49 INFO - 'PAGER': '/bin/cat', 07:56:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:49 INFO - 'PWD': '/builds/slave/test', 07:56:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:49 INFO - 'SHELL': '/bin/bash', 07:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxtf9OS74Q/Listeners', 07:56:49 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 07:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:49 INFO - 'USER': 'cltbld', 07:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:49 INFO - 'XPC_FLAGS': '0x0', 07:56:49 INFO - 'XPC_SERVICE_NAME': '0', 07:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:56:49 INFO - mozversion application_buildid: 20160411065021 07:56:49 INFO - mozversion application_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 07:56:49 INFO - mozversion application_display_name: Nightly 07:56:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:56:49 INFO - mozversion application_name: Firefox 07:56:49 INFO - mozversion application_remotingname: firefox 07:56:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:56:49 INFO - mozversion application_vendor: Mozilla 07:56:49 INFO - mozversion application_version: 48.0a1 07:56:49 INFO - mozversion platform_buildid: 20160411065021 07:56:49 INFO - mozversion platform_changeset: d93a1bc945137dfcc94866f1e30da1f55cfb8d9d 07:56:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:56:49 INFO - mozversion platform_version: 48.0a1 07:56:49 INFO - using testdate: 1460386609 07:56:49 INFO - actual date: 1460386609 07:56:49 INFO - starting webserver on 'localhost:49276' 07:56:49 INFO - SUITE-START | Running 2 tests 07:56:49 INFO - TEST-START | dromaeo_css 07:56:49 INFO - operating with platform_type : mac_ 07:56:49 INFO - Initialising browser for dromaeo_css test... 07:56:49 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp8FCYgf/profile http://localhost:49276/getInfo.html) 07:56:52 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 07:56:52 INFO - PROCESS | 1678 | colorDepth:24 07:56:52 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 07:56:52 INFO - PROCESS | 1678 | __metrics 07:56:52 INFO - PROCESS | 1678 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:56:52 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:56:52 INFO - TEST-INFO | 1678: exit 0 07:56:52 INFO - Browser initialized. 07:56:52 INFO - Running cycle 1/1 for dromaeo_css test... 07:56:52 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmp8FCYgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:04 INFO - PROCESS | 1681 | RSS: Main: 237498368 07:57:04 INFO - PROCESS | 1681 | 07:57:55 INFO - PROCESS | 1681 | 1460386675500 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:00:07 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 08:00:08 INFO - PROCESS | 1681 | RSS: Main: 375500800 08:00:08 INFO - PROCESS | 1681 | 08:03:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:03:12 INFO - PROCESS | 1681 | RSS: Main: 376250368 08:03:12 INFO - PROCESS | 1681 | 08:06:14 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:06:14 INFO - PROCESS | 1681 | RSS: Main: 377679872 08:06:14 INFO - PROCESS | 1681 | 08:09:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:09:17 INFO - PROCESS | 1681 | RSS: Main: 336207872 08:09:17 INFO - PROCESS | 1681 | 08:12:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:12:21 INFO - PROCESS | 1681 | RSS: Main: 340303872 08:12:21 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:15:24 INFO - PROCESS | 1681 | RSS: Main: 396238848 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | __start_tp_report 08:15:24 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 08:15:24 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 08:15:24 INFO - PROCESS | 1681 | |i|pagename|runs| 08:15:24 INFO - PROCESS | 1681 | |0;dojo.html;3389.5085212644167;3443.5179074929497;3467.861285548579;3468.5317482139903;3490.4066308727515;5608.887822243552;5656.066748986423;5667.603267771253;5687.488126068653;5690.118031705082;5579.163125531172;5600.243967064445;5607.7476513556885;5614.3543492498375;5621.213030175779;4226.197022565702;5070.492950704918;5105.5149760772665;5124.032942350886;5166.328377310944;5189.481051894799;5194.844154675366;5195.350581177353;5200.245964335169;5218.452062533436;5187.299714538545;5218.191180367049;5228.398734145584;5237.319148510688;5237.764300606482;5220.634555581092;5253.789848406097;5276.868078298035;5280.155175171954;5412.4587541245955;5099.566536844372;5130.256112863651;5131.563817075553;5192.091384007821;5206.375234971828;5539.667619942776;5553.222548843165;5583.720813959286;5597.244372009767;5601.215829783833;6177.62934223948;6192.380761923771;6199.318075011745;6206.224221972254;6206.782762603332;6090.959528557938;6162.661053642048;6219.87560248797;6281.87436251277;6284.622922624657;5757.337906140764;5760.308762948473;5784.537237021028;5804.9419505805245;5818.069108942549;6253.030780229072;6255.155554000152;6269.965455699758;6274.247090349188;6295.842603934938;5952;6020.106798723161;6086.452219300284;6156.78451254204;6169.876602468015;6106.7334352118005;6142.416470435302;6163.476104531075;6168.660723660152;6175.44421002112;6096.556923351703;6109.009944784373;6116.031445915052;6175.166352542439;6195.659238741822;6140.5701600887505;6201.968990155111;6209.627422354582;6213.502919766408;6231.937680623227;4901.926471102936;4907.705537667752;4914.508549145128;4917.434495033045;4940.283658869444;4362.520122786491;4440.866773996785;4477.462704475483;4479.992001799569;4480.775961201927;5643.097104463266;5664.348599910981;5668.404817494186;5669.121286200645;5671.546276297886;6096.116063170815;6146.647737497743;6182.876342473215;6252.249730032425;6298.212723409574;5672.262605861211;5692.544596432275;5694.686792226385;5702.686352250583;5733.483986441241;5350;5354.063038968165;5368.489993450616;5370.221317908881;5374.140137578047;5522.30971128609;6201.224846894138;6228;6284.402981716729;6314.210723659543;5237.6333656643665;6183.196184495987;6241.095041219089;6265.937340626535;6266.874662506633;6225.470834979077;6259.624422534663;6262.436380725757;6280.466160376419;6281.246250449975;5115.514026167508;6005.669688167192;6116.35778243278;6116.66358350295;6205.875882482234;6230.283517395557;6234.844128896814;6236.968815155895;6239.469645080219;6259.812205633838;5827.562932779973;6035.939640603538;6055.091736239599;6055.515558755201;6096.908546371897;5022.447530771686;5896.262967129109;5986.341502434816;5999.250093738283;6038.75844966214;5792.855178620568;5808.448197421239;5828.7959921404245;5835.649861008353;5845.1232315153065;5915.319738230159;5975.223220981418;6020.217371741645;6033.607815491979;6069.817905462844;5838.678872662044;5877.94122058774;5919.467247947706;5959.22530071088;5976.193213916065 08:15:24 INFO - PROCESS | 1681 | |1;ext.html;502.07367407133836;515.6313236036233;537.8870437208186;596.573449983262;623.015635296232;28259.29351766207;29282.707172928265;29293.707062929363;29343.85328073362;29378.559321610166;30260.54609180864;30795.38409231814;30866;38100.61899381005;39208.62769803058;9321.161095501404;9521.809563808754;9534.04659534048;9566.426014439121;9591.376560523579;9487.52562371882;9643.662471813488;9645.180159686435;9649;9657.806843863118;8524.78688032798;8831;9582.329236953416;11251.54993800247;11643.18497705161;11457.14071444645;11554.595589154424;11572.59495917639;11593.072554195685;11612.12909031826;11304;11451.713707157305;11452.656420307405;11457.14071444645;11464.31214127155;30433.23916902095;38506.614933850586;39365;39387.60612393868;39429.40855887164;3122.453570625154;3229.8546565404613;3311.8675252990092;3347.598288205407;3503.8423270952867;26218.9512419503;26473.073442429424;27050.45899082027;27110.5933410999;27335.45329093427;2678.7321267873253;2688.3413563676827;2702.2028501592076;2716.375233696261;2804.270889568727;400594;403135;403444;405005;405440.99999999703;34551.30897382089;35262;35434.82282588622;56008;56582.585435364446;33854.153646159044;33901.49147762785;34032.48951265733;34131;34182.31635367279;14299.356528956221;14484.420623174956;14485.565433036814;14495.20276384809;14500.564983050524;12215.328156951275;12300.753984920251;12303.876961230451;12311.138220324492;12321.199122057038;7405.481616286916;7898.802529936797;7901.881471777928;7986.041674998921;8006.559639219782;3123.9219019524694;3174.841257937094;3174.9841250793597;3175.872965081417;3215.6784321568125;928.7538802217417;966.3139171188394;989.4162444157981;1050.826613608746;1107.983380249297;21552.353429397142;28742;28751.712482875322;29650.55524167139;29660.555091673643;1110.7389763405592;1134.1720544002924;1141.8809566624755;1165.1843709403452;1167;13647.727045459034;14502.12987220749;14756;15182.164980925934;15184.848151518565;598684;600009;606641.966790172;607532;607854;56267;56957.715211423674;57006.58914341109;57033.714831425576;57059;1169.5146514196513;1307.3071272225736;1421.3299373236612;1439.7768345906402;1466.765317549187;23641.52716945686;28017.719822802326;28200.012999544917;28613.28466788347;28902.42195156043;43309;43741;44125.55874441215;44266.67199984006;44287;286808;287560;289421;289613;291558.0844191531;18829;25053.373665658506;25756.742432575433;25971.61042584325;26066;40776;41041.58958410378;41400.58599413967;41901.580984189764;42149.789251053546;33641.831790840886;34459;34461.03698074653;35057.1235719109;35305.82347088351;33859.66140338565;33934.8303258492;34545.30909381848;34846;36178.8191059043;35416;35691.92924212278;35827.2086395674;36309.818450908635;36646.90059298225;31055.68944310528;31418.842905785325;31508.054758357284;31540.053798386085;31707.73169073211;20157;23890.88054559716;23895.29622908452;23934.28197154088;24169.154079607833 08:15:24 INFO - PROCESS | 1681 | |2;jquery.html;394.7000279787361;396.48654991785634;397.0609508512369;398.5138131479594;408.8262488442413;18800.24799008038;18870;19822.801771982293;19849.503762405948;19857.801421985758;19427.902860485712;19959.301424450146;19973.50066248341;20097.999999999964;20474.05496477836;5472.781088756465;5816.82549523515;5820.679862607555;5822.272215973004;5835.299764028312;5700.333007439313;5734.139879018139;5746.367899531048;5779.682117483537;5780.1907732917425;5710.400407957167;6527.510436717242;6723.966380168117;6733.39399454049;6755.378709109803;6167.629942203437;6171.87656246877;6549.738010479575;6696.129503164581;6730.865382692343;5557.138643510262;5690.146478028288;5703.31560212773;5709.8287051388525;5713.542916566665;13274;23417.41456463585;23875.157874768513;24103.276901692978;24109.879450602635;2013.6274789163906;2062.8143467087884;2116.280464642029;2178.93628383066;2215.601191785478;9216.447013179164;9605.567749451222;9933.55299011539;10012.059732899243;10026.548805303779;1492.2538730634683;1654.8676105911497;1699.2862997541063;1728.5073753980055;1766.3023105873237;101173.48239776409;105692;108767;116211.41894290558;116455.83544164535;11248.325100493996;11436.885631143583;11469.713257168638;11486.368249746343;11661.24201926889;14747.631309217355;14819.407223711147;14832.332545035499;14865.182414967281;14873.47942821996;8278.296344810638;8448.957755211184;8500.319974402033;8605.483670979762;8606.956965215133;8365;8381.622826972802;8479.703210387606;8491.660333586588;8756.781080472912;4427.247367947392;4491.236489796743;4508.120916421266;4581.679282450196;4605.032943081923;1933.8839669619867;1942.6988816733428;1943.6987266973642;1949.3859434278156;1993.182795054021;824.6701319472259;885.8936927568733;892.9641615725727;898.9730308090768;915.7069737683877;15469;19018.42944711661;19409.223631054883;19431.319903803582;19543.902280488506;900.5182227508383;928.0997432490474;940.9388389754644;957.9233661307079;1033.178622994721;8847.51338676379;9258.861117083248;9942.254330925209;10280.537375818107;10300;623298;625941;636932;638850;643135;108892;109465.45267273772;110200.4489977545;113237.43381283041;115870.26194607088;1001.3891526169031;1005.6832097889142;1025.8358662613946;1027.2655051638114;1028.9176865850563;14803.703925921636;15347.462838800588;15995.8400415999;16888.66222675564;16968.40610578624;45147.322790157516;47502.52497474981;47998.04003919972;48573.51426485831;49558;69743.30256697368;70121;70210.59578808294;70825.6458717703;71552.28447715456;6865.862682746218;6986.650667466708;7338.486305958745;7364.5581265124265;7430.4798664093;11353.602623908124;12118.878811211775;12501;12604.87395126037;12897.484100636244;9859.457729824928;10336.328138670962;10502.789944201226;10710.117604811823;10716.464176790972;10055.29612927088;10162.79674406493;10178.694639160836;10371.325863818827;10424.583016679248;10246.282760206714;10764.946175269073;10823.404712740874;10882.510287036945;11005.559777608805;5639.859003524781;7832.686692532235;8013.439059265796;8065.032196136266;8193.46742461738;7097.538659987084;8791.120887911158;8863.689770857989;10712.35725856451;11047 08:15:24 INFO - PROCESS | 1681 | |3;mootools.html;1405;1408.6126315263296;1566.960825979351;1581.691570143822;1993.8404927605793;7861.56761378124;8641.222289993899;8878.156575125353;8888.733337999854;8893;8497.830043399128;8740.125987401258;8757.080506546816;8774.868376974351;8776.07851175627;2445.74319696432;2464.7165575958816;2474.059857254241;2478.281298423455;2481.0944005438064;2232.352617740853;2306.0199415248453;2410.710714714228;2478.467129567143;2482.1064416809936;1916.444231172958;2416.214730212679;2437.1835435129165;2456.6315052742143;2466.2477944227094;2193.694751622782;2402.723686776008;2440.2069327468553;2440.4996975619956;2444.6333050042367;2291.1980806717684;2356.1400088967403;2447.094575007241;2451.399407145243;2459.348272707734;7842.647080881317;8062.717804876801;8687.131286871325;8854.380193386465;8865.46807191564;4440.333949907507;4643.442786865598;4719.292106184065;5189.2475591039465;5364.946350536484;3470.6876381125567;3487.459443786217;3570.2680950405106;3570.393033184339;3590.9461358079648;1004.3622299839654;1038.657243109772;1043.504335440667;1045.8954104589557;1047.706642140202;11521.251118677259;11590.652280431601;11622.941885290604;11624.941875290653;11668.76662466746;4758.952410475851;4845.878853028703;4855.32025516428;4938.530839570307;4956.578690811321;10102.343347682377;10118.898811011943;10133.898661013296;10239.84640230397;10271.794564108675;4910.48439913811;5136.845894623168;5431.266778984866;5448.645838020516;5450.291462109901;4875.902481950341;4893.437254715682;4972.453030166679;4978.452370239271;4983.8006479741125;3268.3299923515624;3369.2419205679016;3839.2513459875613;3877.1470276539117;3965.5241371035086;1277.2591896699892;1281.2888846690175;1288.6778305423645;1290.1807352331336;1309.6922223277522;1336.8596297388829;1357.3416892806981;1359.6600849787553;1364.6383708317303;1385.4042761612402;8074.596270186467;8294.004719433706;8296.294814940677;8300.916990830136;8334.791630209293;505.2421367948078;517.8084108879664;521.0334828892426;521.1115048841716;522.37576096565;5833.82498525045;6047.7278522466595;6261.123442718023;6329.145565348711;6334.904976425265;9311.813763724687;9324.627014919328;9608.375455595504;10158.13655839262;10203.183745300506;10201.132903703268;10584.259101862795;10592.735181620521;10604.045635892806;10620.309679870783;7976.361891048702;8127.471714338549;8226.465279756796;8250.38122140842;8265.380096492787;8141.267285944294;8262.215089566482;8357.874631880404;8364.121767214356;8390.622421990904;9639.277054221102;9664.226861850895;9956.452395118049;9973.50132493387;10071.647492337734;9970.750731231486;10069.69790906274;10364.585416583252;10389.68830935043;10513.842292365774;7294.598797066213;7665.961670191613;7726.729564465217;7813.960930195312;7816.374690024898;8394.11861754507;8407.159284071544;8439.029511605999;8447.40868139249;8467.49195048299;7323.59720215372;7459.328660420588;7482.064741907262;7535.773926782205;7629.389648828192;7207.9639601801655;7361;7412.555246685;7467;7468.9626551866895;7794.844103118019;7833.5691536966015;7885.329746971572;7889.289963903277;7889.566073865993;7071.25751796054;7104.609246491286;7122.964385178248;7162.498625096193;7167.63814875172;7168.103987001625;7259.745908893164;7263.891041634274;7265.600391978492;7272.345488906024 08:15:24 INFO - PROCESS | 1681 | |4;prototype.html;287.87045829376757;319.6132679457856;321.5642804000579;328.16154724678444;333.2285758469144;4596.471405788336;5168.22476628506;5852.824415267538;5901.691765011544;5941.881162376755;5108;5503.752331145098;5740.368559458456;5807.983602869502;5812.854678633025;4044.8382064717375;4128.917421651565;4184.100418410041;4270.419944620479;4374.518802931675;4286.585426809161;4299.613034826865;4319.358643715384;4324.416203812492;4341.826326946918;3536.9115772105647;4250.702450828443;4266.850660226877;4270.295401258789;4318.805653745573;3736.8131593420494;4102.958970410287;4161.001359673687;4237.406763053175;4252.638525725317;3103.3482968576627;3603.1352475405974;3618.154741082067;3711.406175012012;3735.4210097434943;5389.380221274525;5410.323709536308;5434.239206511092;5458.263134476834;5458.808941687022;4689.437267527918;4875.926861097087;4906.656534042619;4912.606991440676;4921.114199444134;5210.775467765072;5745.92592962763;5912.122498938393;5947;6048.334683184846;4052.8317350217785;4054.837806487737;4058.533268674111;4071.42999980003;4075.9388609170887;5690.374058853523;6054.122152287893;6260.968695156541;6479.546431749733;6480.287168411471;4166.958330416657;4190.497140343178;4204.66362690984;4212.326027835532;4227.598378154132;4264.912447325912;4267.317229243306;4271.273883439822;4279.957200427956;4285.657147428198;4819.903601927942;4951.7276549789385;4953;5000.949990500121;5001.399272378343;6169.383061693795;6196.380361963767;6198.132261483396;6220.626762394271;6222.315545290015;1351.594521643503;1360.1906865415062;1442.451868290043;1468.3612628506635;1469.8677119059123;946.3659348236698;956.6699488676395;963.8939716631165;967.9062659195205;977.8412581091429;4794.544518270759;5588.580856435784;5740;5810.1865738796605;5824.301083869963;5247.29764171452;6090.908636370458;6374.012028135647;6382.170317858649;6386.521010924199;5510.421405752419;5749.310082790092;5796.1595568642315;5802.738876750556;5830.7084645767545;3337.399268131711;3338.5993680758465;3340.8997730068136;3343.9164020899184;3356.815375154341;5069.695818250917;5640;6611.305812889674;6613.735450582019;6616.772749527915;6307.621542707452;6489.545731798823;6510.121133646897;6517.804465866032;6533.1180290661105;6513.348665133449;6704.765333213314;6708.42978346846;6736.157980252468;6757.391834734897;5389.75746091419;6194.566380353332;6463.838404039937;6464.931222008912;6494.155759751202;5373.662456831291;6296.496280297657;6314.842128946813;6346.619202847844;6371.267304260069;6017.819465416044;6272.937270627235;6711;6728.226253980855;6756.087928129639;3406.948895766615;4063.349864021742;4167.8332866685;4210;4220.324748040299;5399.758055647145;6269.843253918689;6296.842578935563;6353.174087368612;6363.904541431974;5429.891402171856;5838.5621078418435;6147.618809654761;6155.569110162246;6209.441150296495;6075.848103797263;6112.908306375319;6123.877522449437;6152.447189080138;6163.691815409122;5638.548916086621;5699.686517241592;5853.385394533683;5998.820035398945;6018.4884284834525;5366.651167674088;5952.946233549418;6087.9391206087375;6093.390660933871;6160.260768707783;6000.469880180701;6027.728752206249;6027.75888964454;6028.698565071817;6033.12519684652 08:15:24 INFO - PROCESS | 1681 | |5;yui.html;607.8238608292951;657.5101549345738;697.1599222936362;731.9890201646974;752.9698812047518;14314.427422903085;15293.617659558517;16811.579710507245;17390.391336303233;17432.51823594996;16082.276297566608;16137.642836434185;16150.111743854084;16155.192240387963;16167.353305867751;718.9029481020074;755.263617972478;921.1203300847708;926.0184204742994;929.9721008369726;722.8265216348065;738.8263758016861;922.4649703172178;927.4667066436792;927.9025702301262;954.341504361988;959.7600599850037;966.7099870038995;971.5725080964388;972.810301991112;750.6284389227313;932.9953350233274;950.8478643417054;962.2254085461236;964.7699183541006;709.8225443639091;712.255692801019;715.914090309161;716.1084449859906;716.7312257903286;15118.697626047417;15217;15223.847761522355;15233.542993710207;15243.466478673194;12216.877831221751;12271;12411.75176496474;12460.75078498425;12674.302913339763;9868.901310986941;10145.137663298628;10567.894321056845;10569.41868197249;10825.188110891715;3434.5191673165778;3471.7743346682637;3569.9107522311892;3578.946315805265;3648.5804132524836;83911;84379;84753.57623211906;85404;85997.14002859953;7729.3430058445665;9391.90608093924;9405.717828465156;9504.477253750973;9837.950810245902;21278.468038299165;21472.78527214739;21481.78518214829;21511.46221344479;21524.56950860974;7262.382697470668;7271.127464704269;7295.197528271886;7329.45029122818;7341.816454588571;3995.6603688686205;4040.595940405936;4042.919141617151;4076.694247931417;4193.014641559231;3583.175869550018;3704.2221133562252;3705.6664900158576;3708.7774733516076;3709.6104908984707;643.5495153392644;646.7445359083135;650.9772157974448;654.8395643067383;665.5707068940507;535.7696190638063;589.241115270916;593.9792107276224;597.2206270816627;613.4908026338129;6908.343707347894;7676.57778822159;7971.720989765447;7972;8168;514.5420575687566;527.9128943724319;562.5443390853421;562.9014922388566;590.734169623671;3381.458966565338;3531.611522732497;3583.569971603424;3638.581563120222;3693.538307711536;85789;86434.56782716172;86535.56732216298;87710;87952.56023719968;73449.6327518359;73839;73859.26140738631;73976.63011684908;74965.62517187488;60975.08537371943;61551;63313;67359.66320168368;69238.9614155788;7175.780117380163;7623.504472209289;8038.15599362082;8171.795705107182;8275.793105172419;41249.55626553056;41573.584264158184;41631;42425.5757442434;43260.269589217336;58616;61226.69386653038;61623.691881540304;61627.6918615422;61655.07517387153;10890.782184356427;11179.888201117885;11233.943830281123;11312.94343528277;11365.715857103638;11511.194216405107;11850.348230847387;11861.644150675493;11917.10621703393;12456.377181141088;9330.906690933003;10014.699559013241;10246.846297305696;11337.773244535229;11436.313821170756;11279;11342.376169310766;11505.539778409106;11810.173287869766;12143.817842732542;10418.385503126116;10566.630167944086;11360.602378916697;11392.974632283134;12272.140950133406;9295.07049295065;9460.290478214023;9718.951405242928;9842.507874606385;9847.507624618884;7752.41856860749;9426.293028022788;9631.181349585364;9635.518224088628;9636 08:15:24 INFO - PROCESS | 1681 | __end_tp_report 08:15:24 INFO - PROCESS | 1681 | __start_cc_report 08:15:24 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1280 08:15:24 INFO - PROCESS | 1681 | __end_cc_report 08:15:24 INFO - PROCESS | 1681 | __startTimestamp1460387724514__endTimestamp 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | ------- Summary: start ------- 08:15:24 INFO - PROCESS | 1681 | Number of tests: 6 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5682.15 Median:5828.80 stddev:622.12 (10.7%) stddev-sans-first:597.46 08:15:24 INFO - PROCESS | 1681 | Values: 3389.5 3443.5 3467.9 3468.5 3490.4 5608.9 5656.1 5667.6 5687.5 5690.1 5579.2 5600.2 5607.7 5614.4 5621.2 4226.2 5070.5 5105.5 5124.0 5166.3 5189.5 5194.8 5195.4 5200.2 5218.5 5187.3 5218.2 5228.4 5237.3 5237.8 5220.6 5253.8 5276.9 5280.2 5412.5 5099.6 5130.3 5131.6 5192.1 5206.4 5539.7 5553.2 5583.7 5597.2 5601.2 6177.6 6192.4 6199.3 6206.2 6206.8 6091.0 6162.7 6219.9 6281.9 6284.6 5757.3 5760.3 5784.5 5804.9 5818.1 6253.0 6255.2 6270.0 6274.2 6295.8 5952.0 6020.1 6086.5 6156.8 6169.9 6106.7 6142.4 6163.5 6168.7 6175.4 6096.6 6109.0 6116.0 6175.2 6195.7 6140.6 6202.0 6209.6 6213.5 6231.9 4901.9 4907.7 4914.5 4917.4 4940.3 4362.5 4440.9 4477.5 4480.0 4480.8 5643.1 5664.3 5668.4 5669.1 5671.5 6096.1 6146.6 6182.9 6252.2 6298.2 5672.3 5692.5 5694.7 5702.7 5733.5 5350.0 5354.1 5368.5 5370.2 5374.1 5522.3 6201.2 6228.0 6284.4 6314.2 5237.6 6183.2 6241.1 6265.9 6266.9 6225.5 6259.6 6262.4 6280.5 6281.2 5115.5 6005.7 6116.4 6116.7 6205.9 6230.3 6234.8 6237.0 6239.5 6259.8 5827.6 6035.9 6055.1 6055.5 6096.9 5022.4 5896.3 5986.3 5999.3 6038.8 5792.9 5808.4 5828.8 5835.6 5845.1 5915.3 5975.2 6020.2 6033.6 6069.8 5838.7 5877.9 5919.5 5959.2 5976.2 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:55491.12 Median:3174.91 stddev:120898.71 (3807.9%) stddev-sans-first:121167.36 08:15:24 INFO - PROCESS | 1681 | Values: 502.1 515.6 537.9 596.6 623.0 28259.3 29282.7 29293.7 29343.9 29378.6 30260.5 30795.4 30866.0 38100.6 39208.6 9321.2 9521.8 9534.0 9566.4 9591.4 9487.5 9643.7 9645.2 9649.0 9657.8 8524.8 8831.0 9582.3 11251.5 11643.2 11457.1 11554.6 11572.6 11593.1 11612.1 11304.0 11451.7 11452.7 11457.1 11464.3 30433.2 38506.6 39365.0 39387.6 39429.4 3122.5 3229.9 3311.9 3347.6 3503.8 26219.0 26473.1 27050.5 27110.6 27335.5 2678.7 2688.3 2702.2 2716.4 2804.3 400594.0 403135.0 403444.0 405005.0 405441.0 34551.3 35262.0 35434.8 56008.0 56582.6 33854.2 33901.5 34032.5 34131.0 34182.3 14299.4 14484.4 14485.6 14495.2 14500.6 12215.3 12300.8 12303.9 12311.1 12321.2 7405.5 7898.8 7901.9 7986.0 8006.6 3123.9 3174.8 3175.0 3175.9 3215.7 928.8 966.3 989.4 1050.8 1108.0 21552.4 28742.0 28751.7 29650.6 29660.6 1110.7 1134.2 1141.9 1165.2 1167.0 13647.7 14502.1 14756.0 15182.2 15184.8 598684.0 600009.0 606642.0 607532.0 607854.0 56267.0 56957.7 57006.6 57033.7 57059.0 1169.5 1307.3 1421.3 1439.8 1466.8 23641.5 28017.7 28200.0 28613.3 28902.4 43309.0 43741.0 44125.6 44266.7 44287.0 286808.0 287560.0 289421.0 289613.0 291558.1 18829.0 25053.4 25756.7 25971.6 26066.0 40776.0 41041.6 41400.6 41901.6 42149.8 33641.8 34459.0 34461.0 35057.1 35305.8 33859.7 33934.8 34545.3 34846.0 36178.8 35416.0 35691.9 35827.2 36309.8 36646.9 31055.7 31418.8 31508.1 31540.1 31707.7 20157.0 23890.9 23895.3 23934.3 24169.2 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:34527.21 Median:12252.29 stddev:104886.90 (856.1%) stddev-sans-first:105149.83 08:15:24 INFO - PROCESS | 1681 | Values: 394.7 396.5 397.1 398.5 408.8 18800.2 18870.0 19822.8 19849.5 19857.8 19427.9 19959.3 19973.5 20098.0 20474.1 5472.8 5816.8 5820.7 5822.3 5835.3 5700.3 5734.1 5746.4 5779.7 5780.2 5710.4 6527.5 6724.0 6733.4 6755.4 6167.6 6171.9 6549.7 6696.1 6730.9 5557.1 5690.1 5703.3 5709.8 5713.5 13274.0 23417.4 23875.2 24103.3 24109.9 2013.6 2062.8 2116.3 2178.9 2215.6 9216.4 9605.6 9933.6 10012.1 10026.5 1492.3 1654.9 1699.3 1728.5 1766.3 101173.5 105692.0 108767.0 116211.4 116455.8 11248.3 11436.9 11469.7 11486.4 11661.2 14747.6 14819.4 14832.3 14865.2 14873.5 8278.3 8449.0 8500.3 8605.5 8607.0 8365.0 8381.6 8479.7 8491.7 8756.8 4427.2 4491.2 4508.1 4581.7 4605.0 1933.9 1942.7 1943.7 1949.4 1993.2 824.7 885.9 893.0 899.0 915.7 15469.0 19018.4 19409.2 19431.3 19543.9 900.5 928.1 940.9 957.9 1033.2 8847.5 9258.9 9942.3 10280.5 10300.0 623298.0 625941.0 636932.0 638850.0 643135.0 108892.0 109465.5 110200.4 113237.4 115870.3 1001.4 1005.7 1025.8 1027.3 1028.9 14803.7 15347.5 15995.8 16888.7 16968.4 45147.3 47502.5 47998.0 48573.5 49558.0 69743.3 70121.0 70210.6 70825.6 71552.3 6865.9 6986.7 7338.5 7364.6 7430.5 11353.6 12118.9 12501.0 12604.9 12897.5 9859.5 10336.3 10502.8 10710.1 10716.5 10055.3 10162.8 10178.7 10371.3 10424.6 10246.3 10764.9 10823.4 10882.5 11005.6 5639.9 7832.7 8013.4 8065.0 8193.5 7097.5 8791.1 8863.7 10712.4 11047.0 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6026.84 Median:2744.52 stddev:3216.51 (117.2%) stddev-sans-first:3206.77 08:15:24 INFO - PROCESS | 1681 | Values: 1405.0 1408.6 1567.0 1581.7 1993.8 7861.6 8641.2 8878.2 8888.7 8893.0 8497.8 8740.1 8757.1 8774.9 8776.1 2445.7 2464.7 2474.1 2478.3 2481.1 2232.4 2306.0 2410.7 2478.5 2482.1 1916.4 2416.2 2437.2 2456.6 2466.2 2193.7 2402.7 2440.2 2440.5 2444.6 2291.2 2356.1 2447.1 2451.4 2459.3 7842.6 8062.7 8687.1 8854.4 8865.5 4440.3 4643.4 4719.3 5189.2 5364.9 3470.7 3487.5 3570.3 3570.4 3590.9 1004.4 1038.7 1043.5 1045.9 1047.7 11521.3 11590.7 11622.9 11624.9 11668.8 4759.0 4845.9 4855.3 4938.5 4956.6 10102.3 10118.9 10133.9 10239.8 10271.8 4910.5 5136.8 5431.3 5448.6 5450.3 4875.9 4893.4 4972.5 4978.5 4983.8 3268.3 3369.2 3839.3 3877.1 3965.5 1277.3 1281.3 1288.7 1290.2 1309.7 1336.9 1357.3 1359.7 1364.6 1385.4 8074.6 8294.0 8296.3 8300.9 8334.8 505.2 517.8 521.0 521.1 522.4 5833.8 6047.7 6261.1 6329.1 6334.9 9311.8 9324.6 9608.4 10158.1 10203.2 10201.1 10584.3 10592.7 10604.0 10620.3 7976.4 8127.5 8226.5 8250.4 8265.4 8141.3 8262.2 8357.9 8364.1 8390.6 9639.3 9664.2 9956.5 9973.5 10071.6 9970.8 10069.7 10364.6 10389.7 10513.8 7294.6 7666.0 7726.7 7814.0 7816.4 8394.1 8407.2 8439.0 8447.4 8467.5 7323.6 7459.3 7482.1 7535.8 7629.4 7208.0 7361.0 7412.6 7467.0 7469.0 7794.8 7833.6 7885.3 7889.3 7889.6 7071.3 7104.6 7123.0 7162.5 7167.6 7168.1 7259.7 7263.9 7265.6 7272.3 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:4969.09 Median:5639.27 stddev:1563.79 (27.7%) stddev-sans-first:1528.20 08:15:24 INFO - PROCESS | 1681 | Values: 287.9 319.6 321.6 328.2 333.2 4596.5 5168.2 5852.8 5901.7 5941.9 5108.0 5503.8 5740.4 5808.0 5812.9 4044.8 4128.9 4184.1 4270.4 4374.5 4286.6 4299.6 4319.4 4324.4 4341.8 3536.9 4250.7 4266.9 4270.3 4318.8 3736.8 4103.0 4161.0 4237.4 4252.6 3103.3 3603.1 3618.2 3711.4 3735.4 5389.4 5410.3 5434.2 5458.3 5458.8 4689.4 4875.9 4906.7 4912.6 4921.1 5210.8 5745.9 5912.1 5947.0 6048.3 4052.8 4054.8 4058.5 4071.4 4075.9 5690.4 6054.1 6261.0 6479.5 6480.3 4167.0 4190.5 4204.7 4212.3 4227.6 4264.9 4267.3 4271.3 4280.0 4285.7 4819.9 4951.7 4953.0 5000.9 5001.4 6169.4 6196.4 6198.1 6220.6 6222.3 1351.6 1360.2 1442.5 1468.4 1469.9 946.4 956.7 963.9 967.9 977.8 4794.5 5588.6 5740.0 5810.2 5824.3 5247.3 6090.9 6374.0 6382.2 6386.5 5510.4 5749.3 5796.2 5802.7 5830.7 3337.4 3338.6 3340.9 3343.9 3356.8 5069.7 5640.0 6611.3 6613.7 6616.8 6307.6 6489.5 6510.1 6517.8 6533.1 6513.3 6704.8 6708.4 6736.2 6757.4 5389.8 6194.6 6463.8 6464.9 6494.2 5373.7 6296.5 6314.8 6346.6 6371.3 6017.8 6272.9 6711.0 6728.2 6756.1 3406.9 4063.3 4167.8 4210.0 4220.3 5399.8 6269.8 6296.8 6353.2 6363.9 5429.9 5838.6 6147.6 6155.6 6209.4 6075.8 6112.9 6123.9 6152.4 6163.7 5638.5 5699.7 5853.4 5998.8 6018.5 5366.7 5952.9 6087.9 6093.4 6160.3 6000.5 6027.7 6027.8 6028.7 6033.1 08:15:24 INFO - PROCESS | 1681 | 08:15:24 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:17612.83 Median:30920.09 stddev:24413.52 (79.0%) stddev-sans-first:24448.62 08:15:24 INFO - PROCESS | 1681 | Values: 607.8 657.5 697.2 732.0 753.0 14314.4 15293.6 16811.6 17390.4 17432.5 16082.3 16137.6 16150.1 16155.2 16167.4 718.9 755.3 921.1 926.0 930.0 722.8 738.8 922.5 927.5 927.9 954.3 959.8 966.7 971.6 972.8 750.6 933.0 950.8 962.2 964.8 709.8 712.3 715.9 716.1 716.7 15118.7 15217.0 15223.8 15233.5 15243.5 12216.9 12271.0 12411.8 12460.8 12674.3 9868.9 10145.1 10567.9 10569.4 10825.2 3434.5 3471.8 3569.9 3578.9 3648.6 83911.0 84379.0 84753.6 85404.0 85997.1 7729.3 9391.9 9405.7 9504.5 9838.0 21278.5 21472.8 21481.8 21511.5 21524.6 7262.4 7271.1 7295.2 7329.5 7341.8 3995.7 4040.6 4042.9 4076.7 4193.0 3583.2 3704.2 3705.7 3708.8 3709.6 643.5 646.7 651.0 654.8 665.6 535.8 589.2 594.0 597.2 613.5 6908.3 7676.6 7971.7 7972.0 8168.0 514.5 527.9 562.5 562.9 590.7 3381.5 3531.6 3583.6 3638.6 3693.5 85789.0 86434.6 86535.6 87710.0 87952.6 73449.6 73839.0 73859.3 73976.6 74965.6 60975.1 61551.0 63313.0 67359.7 69239.0 7175.8 7623.5 8038.2 8171.8 8275.8 41249.6 41573.6 41631.0 42425.6 43260.3 58616.0 61226.7 61623.7 61627.7 61655.1 10890.8 11179.9 11233.9 11312.9 11365.7 11511.2 11850.3 11861.6 11917.1 12456.4 9330.9 10014.7 10246.8 11337.8 11436.3 11279.0 11342.4 11505.5 11810.2 12143.8 10418.4 10566.6 11360.6 11393.0 12272.1 9295.1 9460.3 9719.0 9842.5 9847.5 7752.4 9426.3 9631.2 9635.5 9636.0 08:15:24 INFO - PROCESS | 1681 | -------- Summary: end -------- 08:15:24 INFO - PROCESS | 1681 | 08:15:25 INFO - TEST-INFO | 1681: exit 0 08:15:25 INFO - TEST-OK | dromaeo_css | took 1115380ms 08:15:25 INFO - TEST-START | kraken 08:15:25 INFO - operating with platform_type : mac_ 08:15:25 INFO - Initialising browser for kraken test... 08:15:25 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpGSLKqF/profile http://localhost:49276/getInfo.html) 08:15:27 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 08:15:27 INFO - PROCESS | 1686 | colorDepth:24 08:15:27 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 08:15:27 INFO - PROCESS | 1686 | __metrics 08:15:27 INFO - PROCESS | 1686 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:27 ERROR - PROCESS | 1686 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:15:28 INFO - TEST-INFO | 1686: exit 0 08:15:28 INFO - Browser initialized. 08:15:28 INFO - Running cycle 1/1 for kraken test... 08:15:28 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpGSLKqF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:40 INFO - PROCESS | 1688 | RSS: Main: 237613056 08:15:40 INFO - PROCESS | 1688 | 08:15:42 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:15:43 INFO - PROCESS | 1688 | RSS: Main: 286285824 08:15:43 INFO - PROCESS | 1688 | 08:15:46 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:15:47 INFO - PROCESS | 1688 | RSS: Main: 299294720 08:15:47 INFO - PROCESS | 1688 | 08:15:50 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:15:51 INFO - PROCESS | 1688 | RSS: Main: 383729664 08:15:51 INFO - PROCESS | 1688 | 08:15:53 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:15:54 INFO - PROCESS | 1688 | RSS: Main: 285646848 08:15:54 INFO - PROCESS | 1688 | 08:15:56 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:15:56 INFO - PROCESS | 1688 | RSS: Main: 289898496 08:15:56 INFO - PROCESS | 1688 | 08:15:59 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:00 INFO - PROCESS | 1688 | RSS: Main: 327847936 08:16:00 INFO - PROCESS | 1688 | 08:16:03 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:03 INFO - PROCESS | 1688 | RSS: Main: 328687616 08:16:03 INFO - PROCESS | 1688 | 08:16:06 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:16:07 INFO - PROCESS | 1688 | RSS: Main: 327409664 08:16:07 INFO - PROCESS | 1688 | 08:16:08 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:09 INFO - PROCESS | 1688 | RSS: Main: 320147456 08:16:09 INFO - PROCESS | 1688 | 08:16:11 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:16:11 INFO - PROCESS | 1688 | RSS: Main: 326807552 08:16:11 INFO - PROCESS | 1688 | 08:16:13 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:16:14 INFO - PROCESS | 1688 | RSS: Main: 329846784 08:16:14 INFO - PROCESS | 1688 | 08:16:17 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:16:18 INFO - PROCESS | 1688 | RSS: Main: 334815232 08:16:18 INFO - PROCESS | 1688 | 08:16:21 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:16:21 INFO - PROCESS | 1688 | RSS: Main: 332480512 08:16:21 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:16:23 INFO - PROCESS | 1688 | RSS: Main: 397447168 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | __start_tp_report 08:16:23 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 08:16:23 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 08:16:23 INFO - PROCESS | 1688 | |i|pagename|runs| 08:16:23 INFO - PROCESS | 1688 | |0;ai-astar;114;112;112;112;117;161;174;111;111;111 08:16:23 INFO - PROCESS | 1688 | |1;audio-beat-detection;158;143;180;168;137;173;144;162;184;147 08:16:23 INFO - PROCESS | 1688 | |2;audio-dft;186;188;187;161;261;238;182;185;183;181 08:16:23 INFO - PROCESS | 1688 | |3;audio-fft;76;72;84;91;56;58;59;77;94;79 08:16:23 INFO - PROCESS | 1688 | |4;audio-oscillator;96;97;135;78;81;80;124;80;77;128 08:16:23 INFO - PROCESS | 1688 | |5;imaging-gaussian-blur;86;84;87;85;88;85;87;85;87;84 08:16:23 INFO - PROCESS | 1688 | |6;imaging-darkroom;124;147;100;93;93;93;93;94;92;92 08:16:23 INFO - PROCESS | 1688 | |7;imaging-desaturate;85;88;86;87;85;86;87;85;86;87 08:16:23 INFO - PROCESS | 1688 | |8;json-parse-financial;55;57;56;56;59;55;56;72;56;54 08:16:23 INFO - PROCESS | 1688 | |9;json-stringify-tinderbox;66;64;76;76;75;71;68;68;68;68 08:16:23 INFO - PROCESS | 1688 | |10;stanford-crypto-aes;85;85;84;87;84;99;105;83;86;87 08:16:23 INFO - PROCESS | 1688 | |11;stanford-crypto-ccm;145;144;170;165;158;161;145;149;168;145 08:16:23 INFO - PROCESS | 1688 | |12;stanford-crypto-pbkdf2;212;213;171;172;222;220;173;170;167;165 08:16:23 INFO - PROCESS | 1688 | |13;stanford-crypto-sha256-iterative;68;70;68;68;69;68;58;75;100;98 08:16:23 INFO - PROCESS | 1688 | __end_tp_report 08:16:23 INFO - PROCESS | 1688 | __start_cc_report 08:16:23 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,1952 08:16:23 INFO - PROCESS | 1688 | __end_cc_report 08:16:23 INFO - PROCESS | 1688 | __startTimestamp1460387783915__endTimestamp 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | ------- Summary: start ------- 08:16:23 INFO - PROCESS | 1688 | Number of tests: 14 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#0] ai-astar Cycles:10 Average:123.50 Median:113.00 stddev:23.46 (20.8%) stddev-sans-first:24.63 08:16:23 INFO - PROCESS | 1688 | Values: 114.0 112.0 112.0 112.0 117.0 161.0 174.0 111.0 111.0 111.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#1] audio-beat-detection Cycles:10 Average:159.60 Median:165.00 stddev:16.53 (10.0%) stddev-sans-first:17.52 08:16:23 INFO - PROCESS | 1688 | Values: 158.0 143.0 180.0 168.0 137.0 173.0 144.0 162.0 184.0 147.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#2] audio-dft Cycles:10 Average:195.20 Median:186.50 stddev:30.12 (16.1%) stddev-sans-first:31.76 08:16:23 INFO - PROCESS | 1688 | Values: 186.0 188.0 187.0 161.0 261.0 238.0 182.0 185.0 183.0 181.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#3] audio-fft Cycles:10 Average:74.60 Median:78.00 stddev:13.47 (17.3%) stddev-sans-first:14.28 08:16:23 INFO - PROCESS | 1688 | Values: 76.0 72.0 84.0 91.0 56.0 58.0 59.0 77.0 94.0 79.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:80.00 stddev:22.92 (28.6%) stddev-sans-first:24.30 08:16:23 INFO - PROCESS | 1688 | Values: 96.0 97.0 135.0 78.0 81.0 80.0 124.0 80.0 77.0 128.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.50 stddev:1.40 (1.6%) stddev-sans-first:1.48 08:16:23 INFO - PROCESS | 1688 | Values: 86.0 84.0 87.0 85.0 88.0 85.0 87.0 85.0 87.0 84.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:93.00 stddev:18.56 (20.0%) stddev-sans-first:17.92 08:16:23 INFO - PROCESS | 1688 | Values: 124.0 147.0 100.0 93.0 93.0 93.0 93.0 94.0 92.0 92.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:1.03 (1.2%) stddev-sans-first:1.00 08:16:23 INFO - PROCESS | 1688 | Values: 85.0 88.0 86.0 87.0 85.0 86.0 87.0 85.0 86.0 87.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:56.00 stddev:5.23 (9.3%) stddev-sans-first:5.46 08:16:23 INFO - PROCESS | 1688 | Values: 55.0 57.0 56.0 56.0 59.0 55.0 56.0 72.0 56.0 54.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:69.50 stddev:4.29 (6.2%) stddev-sans-first:4.30 08:16:23 INFO - PROCESS | 1688 | Values: 66.0 64.0 76.0 76.0 75.0 71.0 68.0 68.0 68.0 68.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:85.50 stddev:7.37 (8.6%) stddev-sans-first:7.70 08:16:23 INFO - PROCESS | 1688 | Values: 85.0 85.0 84.0 87.0 84.0 99.0 105.0 83.0 86.0 87.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:159.50 stddev:10.52 (6.6%) stddev-sans-first:10.52 08:16:23 INFO - PROCESS | 1688 | Values: 145.0 144.0 170.0 165.0 158.0 161.0 145.0 149.0 168.0 145.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.50 Median:192.50 stddev:24.59 (12.8%) stddev-sans-first:24.57 08:16:23 INFO - PROCESS | 1688 | Values: 212.0 213.0 171.0 172.0 222.0 220.0 173.0 170.0 167.0 165.0 08:16:23 INFO - PROCESS | 1688 | 08:16:23 INFO - PROCESS | 1688 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:68.50 stddev:13.72 (20.0%) stddev-sans-first:14.37 08:16:23 INFO - PROCESS | 1688 | Values: 68.0 70.0 68.0 68.0 69.0 68.0 58.0 75.0 100.0 98.0 08:16:23 INFO - PROCESS | 1688 | -------- Summary: end -------- 08:16:23 INFO - PROCESS | 1688 | 08:16:24 INFO - TEST-INFO | 1688: exit 0 08:16:24 INFO - TEST-OK | kraken | took 59529ms 08:16:24 INFO - SUITE-END | took 1174s 08:16:25 INFO - Completed test suite (00:19:35) 08:16:25 INFO - javascript benchmark 08:16:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3389.5085212644167, 3443.5179074929497, 3467.861285548579, 3468.5317482139903, 3490.4066308727515, 5608.887822243552, 5656.066748986423, 5667.603267771253, 5687.488126068653, 5690.118031705082, 5579.163125531172, 5600.243967064445, 5607.7476513556885, 5614.3543492498375, 5621.213030175779, 4226.197022565702, 5070.492950704918, 5105.5149760772665, 5124.032942350886, 5166.328377310944, 5189.481051894799, 5194.844154675366, 5195.350581177353, 5200.245964335169, 5218.452062533436, 5187.299714538545, 5218.191180367049, 5228.398734145584, 5237.319148510688, 5237.764300606482, 5220.634555581092, 5253.789848406097, 5276.868078298035, 5280.155175171954, 5412.4587541245955, 5099.566536844372, 5130.256112863651, 5131.563817075553, 5192.091384007821, 5206.375234971828, 5539.667619942776, 5553.222548843165, 5583.720813959286, 5597.244372009767, 5601.215829783833, 6177.62934223948, 6192.380761923771, 6199.318075011745, 6206.224221972254, 6206.782762603332, 6090.959528557938, 6162.661053642048, 6219.87560248797, 6281.87436251277, 6284.622922624657, 5757.337906140764, 5760.308762948473, 5784.537237021028, 5804.9419505805245, 5818.069108942549, 6253.030780229072, 6255.155554000152, 6269.965455699758, 6274.247090349188, 6295.842603934938, 5952.0, 6020.106798723161, 6086.452219300284, 6156.78451254204, 6169.876602468015, 6106.7334352118005, 6142.416470435302, 6163.476104531075, 6168.660723660152, 6175.44421002112, 6096.556923351703, 6109.009944784373, 6116.031445915052, 6175.166352542439, 6195.659238741822, 6140.5701600887505, 6201.968990155111, 6209.627422354582, 6213.502919766408, 6231.937680623227, 4901.926471102936, 4907.705537667752, 4914.508549145128, 4917.434495033045, 4940.283658869444, 4362.520122786491, 4440.866773996785, 4477.462704475483, 4479.992001799569, 4480.775961201927, 5643.097104463266, 5664.348599910981, 5668.404817494186, 5669.121286200645, 5671.546276297886, 6096.116063170815, 6146.647737497743, 6182.876342473215, 6252.249730032425, 6298.212723409574, 5672.262605861211, 5692.544596432275, 5694.686792226385, 5702.686352250583, 5733.483986441241, 5350.0, 5354.063038968165, 5368.489993450616, 5370.221317908881, 5374.140137578047, 5522.30971128609, 6201.224846894138, 6228.0, 6284.402981716729, 6314.210723659543, 5237.6333656643665, 6183.196184495987, 6241.095041219089, 6265.937340626535, 6266.874662506633, 6225.470834979077, 6259.624422534663, 6262.436380725757, 6280.466160376419, 6281.246250449975, 5115.514026167508, 6005.669688167192, 6116.35778243278, 6116.66358350295, 6205.875882482234, 6230.283517395557, 6234.844128896814, 6236.968815155895, 6239.469645080219, 6259.812205633838, 5827.562932779973, 6035.939640603538, 6055.091736239599, 6055.515558755201, 6096.908546371897, 5022.447530771686, 5896.262967129109, 5986.341502434816, 5999.250093738283, 6038.75844966214, 5792.855178620568, 5808.448197421239, 5828.7959921404245, 5835.649861008353, 5845.1232315153065, 5915.319738230159, 5975.223220981418, 6020.217371741645, 6033.607815491979, 6069.817905462844, 5838.678872662044, 5877.94122058774, 5919.467247947706, 5959.22530071088, 5976.193213916065], "value": 5644.741212259474, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.07367407133836, 515.6313236036233, 537.8870437208186, 596.573449983262, 623.015635296232, 28259.29351766207, 29282.707172928265, 29293.707062929363, 29343.85328073362, 29378.559321610166, 30260.54609180864, 30795.38409231814, 30866.0, 38100.61899381005, 39208.62769803058, 9321.161095501404, 9521.809563808754, 9534.04659534048, 9566.426014439121, 9591.376560523579, 9487.52562371882, 9643.662471813488, 9645.180159686435, 9649.0, 9657.806843863118, 8524.78688032798, 8831.0, 9582.329236953416, 11251.54993800247, 11643.18497705161, 11457.14071444645, 11554.595589154424, 11572.59495917639, 11593.072554195685, 11612.12909031826, 11304.0, 11451.713707157305, 11452.656420307405, 11457.14071444645, 11464.31214127155, 30433.23916902095, 38506.614933850586, 39365.0, 39387.60612393868, 39429.40855887164, 3122.453570625154, 3229.8546565404613, 3311.8675252990092, 3347.598288205407, 3503.8423270952867, 26218.9512419503, 26473.073442429424, 27050.45899082027, 27110.5933410999, 27335.45329093427, 2678.7321267873253, 2688.3413563676827, 2702.2028501592076, 2716.375233696261, 2804.270889568727, 400594.0, 403135.0, 403444.0, 405005.0, 405440.99999999703, 34551.30897382089, 35262.0, 35434.82282588622, 56008.0, 56582.585435364446, 33854.153646159044, 33901.49147762785, 34032.48951265733, 34131.0, 34182.31635367279, 14299.356528956221, 14484.420623174956, 14485.565433036814, 14495.20276384809, 14500.564983050524, 12215.328156951275, 12300.753984920251, 12303.876961230451, 12311.138220324492, 12321.199122057038, 7405.481616286916, 7898.802529936797, 7901.881471777928, 7986.041674998921, 8006.559639219782, 3123.9219019524694, 3174.841257937094, 3174.9841250793597, 3175.872965081417, 3215.6784321568125, 928.7538802217417, 966.3139171188394, 989.4162444157981, 1050.826613608746, 1107.983380249297, 21552.353429397142, 28742.0, 28751.712482875322, 29650.55524167139, 29660.555091673643, 1110.7389763405592, 1134.1720544002924, 1141.8809566624755, 1165.1843709403452, 1167.0, 13647.727045459034, 14502.12987220749, 14756.0, 15182.164980925934, 15184.848151518565, 598684.0, 600009.0, 606641.966790172, 607532.0, 607854.0, 56267.0, 56957.715211423674, 57006.58914341109, 57033.714831425576, 57059.0, 1169.5146514196513, 1307.3071272225736, 1421.3299373236612, 1439.7768345906402, 1466.765317549187, 23641.52716945686, 28017.719822802326, 28200.012999544917, 28613.28466788347, 28902.42195156043, 43309.0, 43741.0, 44125.55874441215, 44266.67199984006, 44287.0, 286808.0, 287560.0, 289421.0, 289613.0, 291558.0844191531, 18829.0, 25053.373665658506, 25756.742432575433, 25971.61042584325, 26066.0, 40776.0, 41041.58958410378, 41400.58599413967, 41901.580984189764, 42149.789251053546, 33641.831790840886, 34459.0, 34461.03698074653, 35057.1235719109, 35305.82347088351, 33859.66140338565, 33934.8303258492, 34545.30909381848, 34846.0, 36178.8191059043, 35416.0, 35691.92924212278, 35827.2086395674, 36309.818450908635, 36646.90059298225, 31055.68944310528, 31418.842905785325, 31508.054758357284, 31540.053798386085, 31707.73169073211, 20157.0, 23890.88054559716, 23895.29622908452, 23934.28197154088, 24169.154079607833], "value": 17313.737263251078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.7000279787361, 396.48654991785634, 397.0609508512369, 398.5138131479594, 408.8262488442413, 18800.24799008038, 18870.0, 19822.801771982293, 19849.503762405948, 19857.801421985758, 19427.902860485712, 19959.301424450146, 19973.50066248341, 20097.999999999964, 20474.05496477836, 5472.781088756465, 5816.82549523515, 5820.679862607555, 5822.272215973004, 5835.299764028312, 5700.333007439313, 5734.139879018139, 5746.367899531048, 5779.682117483537, 5780.1907732917425, 5710.400407957167, 6527.510436717242, 6723.966380168117, 6733.39399454049, 6755.378709109803, 6167.629942203437, 6171.87656246877, 6549.738010479575, 6696.129503164581, 6730.865382692343, 5557.138643510262, 5690.146478028288, 5703.31560212773, 5709.8287051388525, 5713.542916566665, 13274.0, 23417.41456463585, 23875.157874768513, 24103.276901692978, 24109.879450602635, 2013.6274789163906, 2062.8143467087884, 2116.280464642029, 2178.93628383066, 2215.601191785478, 9216.447013179164, 9605.567749451222, 9933.55299011539, 10012.059732899243, 10026.548805303779, 1492.2538730634683, 1654.8676105911497, 1699.2862997541063, 1728.5073753980055, 1766.3023105873237, 101173.48239776409, 105692.0, 108767.0, 116211.41894290558, 116455.83544164535, 11248.325100493996, 11436.885631143583, 11469.713257168638, 11486.368249746343, 11661.24201926889, 14747.631309217355, 14819.407223711147, 14832.332545035499, 14865.182414967281, 14873.47942821996, 8278.296344810638, 8448.957755211184, 8500.319974402033, 8605.483670979762, 8606.956965215133, 8365.0, 8381.622826972802, 8479.703210387606, 8491.660333586588, 8756.781080472912, 4427.247367947392, 4491.236489796743, 4508.120916421266, 4581.679282450196, 4605.032943081923, 1933.8839669619867, 1942.6988816733428, 1943.6987266973642, 1949.3859434278156, 1993.182795054021, 824.6701319472259, 885.8936927568733, 892.9641615725727, 898.9730308090768, 915.7069737683877, 15469.0, 19018.42944711661, 19409.223631054883, 19431.319903803582, 19543.902280488506, 900.5182227508383, 928.0997432490474, 940.9388389754644, 957.9233661307079, 1033.178622994721, 8847.51338676379, 9258.861117083248, 9942.254330925209, 10280.537375818107, 10300.0, 623298.0, 625941.0, 636932.0, 638850.0, 643135.0, 108892.0, 109465.45267273772, 110200.4489977545, 113237.43381283041, 115870.26194607088, 1001.3891526169031, 1005.6832097889142, 1025.8358662613946, 1027.2655051638114, 1028.9176865850563, 14803.703925921636, 15347.462838800588, 15995.8400415999, 16888.66222675564, 16968.40610578624, 45147.322790157516, 47502.52497474981, 47998.04003919972, 48573.51426485831, 49558.0, 69743.30256697368, 70121.0, 70210.59578808294, 70825.6458717703, 71552.28447715456, 6865.862682746218, 6986.650667466708, 7338.486305958745, 7364.5581265124265, 7430.4798664093, 11353.602623908124, 12118.878811211775, 12501.0, 12604.87395126037, 12897.484100636244, 9859.457729824928, 10336.328138670962, 10502.789944201226, 10710.117604811823, 10716.464176790972, 10055.29612927088, 10162.79674406493, 10178.694639160836, 10371.325863818827, 10424.583016679248, 10246.282760206714, 10764.946175269073, 10823.404712740874, 10882.510287036945, 11005.559777608805, 5639.859003524781, 7832.686692532235, 8013.439059265796, 8065.032196136266, 8193.46742461738, 7097.538659987084, 8791.120887911158, 8863.689770857989, 10712.35725856451, 11047.0], "value": 9179.521433845955, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.0, 1408.6126315263296, 1566.960825979351, 1581.691570143822, 1993.8404927605793, 7861.56761378124, 8641.222289993899, 8878.156575125353, 8888.733337999854, 8893.0, 8497.830043399128, 8740.125987401258, 8757.080506546816, 8774.868376974351, 8776.07851175627, 2445.74319696432, 2464.7165575958816, 2474.059857254241, 2478.281298423455, 2481.0944005438064, 2232.352617740853, 2306.0199415248453, 2410.710714714228, 2478.467129567143, 2482.1064416809936, 1916.444231172958, 2416.214730212679, 2437.1835435129165, 2456.6315052742143, 2466.2477944227094, 2193.694751622782, 2402.723686776008, 2440.2069327468553, 2440.4996975619956, 2444.6333050042367, 2291.1980806717684, 2356.1400088967403, 2447.094575007241, 2451.399407145243, 2459.348272707734, 7842.647080881317, 8062.717804876801, 8687.131286871325, 8854.380193386465, 8865.46807191564, 4440.333949907507, 4643.442786865598, 4719.292106184065, 5189.2475591039465, 5364.946350536484, 3470.6876381125567, 3487.459443786217, 3570.2680950405106, 3570.393033184339, 3590.9461358079648, 1004.3622299839654, 1038.657243109772, 1043.504335440667, 1045.8954104589557, 1047.706642140202, 11521.251118677259, 11590.652280431601, 11622.941885290604, 11624.941875290653, 11668.76662466746, 4758.952410475851, 4845.878853028703, 4855.32025516428, 4938.530839570307, 4956.578690811321, 10102.343347682377, 10118.898811011943, 10133.898661013296, 10239.84640230397, 10271.794564108675, 4910.48439913811, 5136.845894623168, 5431.266778984866, 5448.645838020516, 5450.291462109901, 4875.902481950341, 4893.437254715682, 4972.453030166679, 4978.452370239271, 4983.8006479741125, 3268.3299923515624, 3369.2419205679016, 3839.2513459875613, 3877.1470276539117, 3965.5241371035086, 1277.2591896699892, 1281.2888846690175, 1288.6778305423645, 1290.1807352331336, 1309.6922223277522, 1336.8596297388829, 1357.3416892806981, 1359.6600849787553, 1364.6383708317303, 1385.4042761612402, 8074.596270186467, 8294.004719433706, 8296.294814940677, 8300.916990830136, 8334.791630209293, 505.2421367948078, 517.8084108879664, 521.0334828892426, 521.1115048841716, 522.37576096565, 5833.82498525045, 6047.7278522466595, 6261.123442718023, 6329.145565348711, 6334.904976425265, 9311.813763724687, 9324.627014919328, 9608.375455595504, 10158.13655839262, 10203.183745300506, 10201.132903703268, 10584.259101862795, 10592.735181620521, 10604.045635892806, 10620.309679870783, 7976.361891048702, 8127.471714338549, 8226.465279756796, 8250.38122140842, 8265.380096492787, 8141.267285944294, 8262.215089566482, 8357.874631880404, 8364.121767214356, 8390.622421990904, 9639.277054221102, 9664.226861850895, 9956.452395118049, 9973.50132493387, 10071.647492337734, 9970.750731231486, 10069.69790906274, 10364.585416583252, 10389.68830935043, 10513.842292365774, 7294.598797066213, 7665.961670191613, 7726.729564465217, 7813.960930195312, 7816.374690024898, 8394.11861754507, 8407.159284071544, 8439.029511605999, 8447.40868139249, 8467.49195048299, 7323.59720215372, 7459.328660420588, 7482.064741907262, 7535.773926782205, 7629.389648828192, 7207.9639601801655, 7361.0, 7412.555246685, 7467.0, 7468.9626551866895, 7794.844103118019, 7833.5691536966015, 7885.329746971572, 7889.289963903277, 7889.566073865993, 7071.25751796054, 7104.609246491286, 7122.964385178248, 7162.498625096193, 7167.63814875172, 7168.103987001625, 7259.745908893164, 7263.891041634274, 7265.600391978492, 7272.345488906024], "value": 4812.906670717886, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.87045829376757, 319.6132679457856, 321.5642804000579, 328.16154724678444, 333.2285758469144, 4596.471405788336, 5168.22476628506, 5852.824415267538, 5901.691765011544, 5941.881162376755, 5108.0, 5503.752331145098, 5740.368559458456, 5807.983602869502, 5812.854678633025, 4044.8382064717375, 4128.917421651565, 4184.100418410041, 4270.419944620479, 4374.518802931675, 4286.585426809161, 4299.613034826865, 4319.358643715384, 4324.416203812492, 4341.826326946918, 3536.9115772105647, 4250.702450828443, 4266.850660226877, 4270.295401258789, 4318.805653745573, 3736.8131593420494, 4102.958970410287, 4161.001359673687, 4237.406763053175, 4252.638525725317, 3103.3482968576627, 3603.1352475405974, 3618.154741082067, 3711.406175012012, 3735.4210097434943, 5389.380221274525, 5410.323709536308, 5434.239206511092, 5458.263134476834, 5458.808941687022, 4689.437267527918, 4875.926861097087, 4906.656534042619, 4912.606991440676, 4921.114199444134, 5210.775467765072, 5745.92592962763, 5912.122498938393, 5947.0, 6048.334683184846, 4052.8317350217785, 4054.837806487737, 4058.533268674111, 4071.42999980003, 4075.9388609170887, 5690.374058853523, 6054.122152287893, 6260.968695156541, 6479.546431749733, 6480.287168411471, 4166.958330416657, 4190.497140343178, 4204.66362690984, 4212.326027835532, 4227.598378154132, 4264.912447325912, 4267.317229243306, 4271.273883439822, 4279.957200427956, 4285.657147428198, 4819.903601927942, 4951.7276549789385, 4953.0, 5000.949990500121, 5001.399272378343, 6169.383061693795, 6196.380361963767, 6198.132261483396, 6220.626762394271, 6222.315545290015, 1351.594521643503, 1360.1906865415062, 1442.451868290043, 1468.3612628506635, 1469.8677119059123, 946.3659348236698, 956.6699488676395, 963.8939716631165, 967.9062659195205, 977.8412581091429, 4794.544518270759, 5588.580856435784, 5740.0, 5810.1865738796605, 5824.301083869963, 5247.29764171452, 6090.908636370458, 6374.012028135647, 6382.170317858649, 6386.521010924199, 5510.421405752419, 5749.310082790092, 5796.1595568642315, 5802.738876750556, 5830.7084645767545, 3337.399268131711, 3338.5993680758465, 3340.8997730068136, 3343.9164020899184, 3356.815375154341, 5069.695818250917, 5640.0, 6611.305812889674, 6613.735450582019, 6616.772749527915, 6307.621542707452, 6489.545731798823, 6510.121133646897, 6517.804465866032, 6533.1180290661105, 6513.348665133449, 6704.765333213314, 6708.42978346846, 6736.157980252468, 6757.391834734897, 5389.75746091419, 6194.566380353332, 6463.838404039937, 6464.931222008912, 6494.155759751202, 5373.662456831291, 6296.496280297657, 6314.842128946813, 6346.619202847844, 6371.267304260069, 6017.819465416044, 6272.937270627235, 6711.0, 6728.226253980855, 6756.087928129639, 3406.948895766615, 4063.349864021742, 4167.8332866685, 4210.0, 4220.324748040299, 5399.758055647145, 6269.843253918689, 6296.842578935563, 6353.174087368612, 6363.904541431974, 5429.891402171856, 5838.5621078418435, 6147.618809654761, 6155.569110162246, 6209.441150296495, 6075.848103797263, 6112.908306375319, 6123.877522449437, 6152.447189080138, 6163.691815409122, 5638.548916086621, 5699.686517241592, 5853.385394533683, 5998.820035398945, 6018.4884284834525, 5366.651167674088, 5952.946233549418, 6087.9391206087375, 6093.390660933871, 6160.260768707783, 6000.469880180701, 6027.728752206249, 6027.75888964454, 6028.698565071817, 6033.12519684652], "value": 4463.908608517261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.8238608292951, 657.5101549345738, 697.1599222936362, 731.9890201646974, 752.9698812047518, 14314.427422903085, 15293.617659558517, 16811.579710507245, 17390.391336303233, 17432.51823594996, 16082.276297566608, 16137.642836434185, 16150.111743854084, 16155.192240387963, 16167.353305867751, 718.9029481020074, 755.263617972478, 921.1203300847708, 926.0184204742994, 929.9721008369726, 722.8265216348065, 738.8263758016861, 922.4649703172178, 927.4667066436792, 927.9025702301262, 954.341504361988, 959.7600599850037, 966.7099870038995, 971.5725080964388, 972.810301991112, 750.6284389227313, 932.9953350233274, 950.8478643417054, 962.2254085461236, 964.7699183541006, 709.8225443639091, 712.255692801019, 715.914090309161, 716.1084449859906, 716.7312257903286, 15118.697626047417, 15217.0, 15223.847761522355, 15233.542993710207, 15243.466478673194, 12216.877831221751, 12271.0, 12411.75176496474, 12460.75078498425, 12674.302913339763, 9868.901310986941, 10145.137663298628, 10567.894321056845, 10569.41868197249, 10825.188110891715, 3434.5191673165778, 3471.7743346682637, 3569.9107522311892, 3578.946315805265, 3648.5804132524836, 83911.0, 84379.0, 84753.57623211906, 85404.0, 85997.14002859953, 7729.3430058445665, 9391.90608093924, 9405.717828465156, 9504.477253750973, 9837.950810245902, 21278.468038299165, 21472.78527214739, 21481.78518214829, 21511.46221344479, 21524.56950860974, 7262.382697470668, 7271.127464704269, 7295.197528271886, 7329.45029122818, 7341.816454588571, 3995.6603688686205, 4040.595940405936, 4042.919141617151, 4076.694247931417, 4193.014641559231, 3583.175869550018, 3704.2221133562252, 3705.6664900158576, 3708.7774733516076, 3709.6104908984707, 643.5495153392644, 646.7445359083135, 650.9772157974448, 654.8395643067383, 665.5707068940507, 535.7696190638063, 589.241115270916, 593.9792107276224, 597.2206270816627, 613.4908026338129, 6908.343707347894, 7676.57778822159, 7971.720989765447, 7972.0, 8168.0, 514.5420575687566, 527.9128943724319, 562.5443390853421, 562.9014922388566, 590.734169623671, 3381.458966565338, 3531.611522732497, 3583.569971603424, 3638.581563120222, 3693.538307711536, 85789.0, 86434.56782716172, 86535.56732216298, 87710.0, 87952.56023719968, 73449.6327518359, 73839.0, 73859.26140738631, 73976.63011684908, 74965.62517187488, 60975.08537371943, 61551.0, 63313.0, 67359.66320168368, 69238.9614155788, 7175.780117380163, 7623.504472209289, 8038.15599362082, 8171.795705107182, 8275.793105172419, 41249.55626553056, 41573.584264158184, 41631.0, 42425.5757442434, 43260.269589217336, 58616.0, 61226.69386653038, 61623.691881540304, 61627.6918615422, 61655.07517387153, 10890.782184356427, 11179.888201117885, 11233.943830281123, 11312.94343528277, 11365.715857103638, 11511.194216405107, 11850.348230847387, 11861.644150675493, 11917.10621703393, 12456.377181141088, 9330.906690933003, 10014.699559013241, 10246.846297305696, 11337.773244535229, 11436.313821170756, 11279.0, 11342.376169310766, 11505.539778409106, 11810.173287869766, 12143.817842732542, 10418.385503126116, 10566.630167944086, 11360.602378916697, 11392.974632283134, 12272.140950133406, 9295.07049295065, 9460.290478214023, 9718.951405242928, 9842.507874606385, 9847.507624618884, 7752.41856860749, 9426.293028022788, 9631.181349585364, 9635.518224088628, 9636.0], "value": 6776.386712732343, "unit": "score"}], "name": "dromaeo_css", "value": 7123.0909424651745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 112.0, 112.0, 117.0, 161.0, 174.0, 111.0, 111.0, 111.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 143.0, 180.0, 168.0, 137.0, 173.0, 144.0, 162.0, 184.0, 147.0], "value": 159.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 187.0, 161.0, 261.0, 238.0, 182.0, 185.0, 183.0, 181.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 72.0, 84.0, 91.0, 56.0, 58.0, 59.0, 77.0, 94.0, 79.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 135.0, 78.0, 81.0, 80.0, 124.0, 80.0, 77.0, 128.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 85.0, 88.0, 85.0, 87.0, 85.0, 87.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 147.0, 100.0, 93.0, 93.0, 93.0, 93.0, 94.0, 92.0, 92.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 86.0, 87.0, 85.0, 86.0, 87.0, 85.0, 86.0, 87.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 56.0, 59.0, 55.0, 56.0, 72.0, 56.0, 54.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 76.0, 76.0, 75.0, 71.0, 68.0, 68.0, 68.0, 68.0], "value": 70.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 87.0, 84.0, 99.0, 105.0, 83.0, 86.0, 87.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 170.0, 165.0, 158.0, 161.0, 145.0, 149.0, 168.0, 145.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 213.0, 171.0, 172.0, 222.0, 220.0, 173.0, 170.0, 167.0, 165.0], "value": 188.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 58.0, 75.0, 100.0, 98.0], "value": 74.2, "unit": "score"}], "name": "kraken", "value": 1558.4, "alertThreshold": 2.0}]} 08:16:25 INFO - Return code: 0 08:16:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:16:25 ERROR - # TBPL SUCCESS # 08:16:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:16:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:16:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:16:25 INFO - 2016-04-11 08:16:25.178 screenresolution[1692:10989] starting screenresolution argv=screenresolution get 08:16:25 INFO - 2016-04-11 08:16:25.181 screenresolution[1692:10989] Display 0: 1600x1200x32@60 08:16:25 INFO - 2016-04-11 08:16:25.186 screenresolution[1693:10992] starting screenresolution argv=screenresolution list 08:16:25 INFO - Available Modes on Display 0 08:16:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:16:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:16:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:16:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:16:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:16:25 INFO - Intel Iris: 08:16:25 INFO - Chipset Model: Intel Iris 08:16:25 INFO - Type: GPU 08:16:25 INFO - Bus: Built-In 08:16:25 INFO - VRAM (Dynamic, Max): 1536 MB 08:16:25 INFO - Vendor: Intel (0x8086) 08:16:25 INFO - Device ID: 0x0a2e 08:16:25 INFO - Revision ID: 0x0009 08:16:25 INFO - Displays: 08:16:25 INFO - Display: 08:16:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:16:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:16:25 INFO - Display Serial Number: 1600x1200 60 08:16:25 INFO - Main Display: Yes 08:16:25 INFO - Mirror: Off 08:16:25 INFO - Online: Yes 08:16:25 INFO - Rotation: Supported 08:16:25 INFO - Return code: 0 08:16:25 INFO - Running post-action listener: _resource_record_post_action 08:16:25 INFO - Running post-run listener: _resource_record_post_run 08:16:26 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 32148992; Write bytes: 693351424; Read time: 318; Write time: 2152 08:16:26 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 383717888; Write bytes: 376051200; Read time: 28497; Write time: 725 08:16:26 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30363136; Write bytes: 297725440; Read time: 299; Write time: 1389 08:16:26 INFO - Running post-run listener: _upload_blobber_files 08:16:26 INFO - Blob upload gear active. 08:16:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:16:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:16:26 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'] 08:16:26 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 08:16:26 INFO - (blobuploader) - INFO - Open directory for files ... 08:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:16:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:28 INFO - (blobuploader) - INFO - Done attempting. 08:16:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:16:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:16:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:16:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:16:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:16:29 INFO - (blobuploader) - INFO - Done attempting. 08:16:29 INFO - (blobuploader) - INFO - Iteration through files over. 08:16:29 INFO - Return code: 0 08:16:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:16:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:16:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47fde7baa31e70da2d6eb9848e3a5b1c9d254c5f514cc5638f19ef465f6dd49e63d7ec42d4af534e8dd749a8110344f024f43f001f034973d00f121fa5ee4b86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb91bbf74dca718fd9bffa01b2d23039ecc84a9ed172420d0313d6efab04cb2a3a84bf86a9ab6a70229cd9d522f423f6f623ecc03cdf74011c760c4b1975b61e"} 08:16:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:16:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:16:29 INFO - Contents: 08:16:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47fde7baa31e70da2d6eb9848e3a5b1c9d254c5f514cc5638f19ef465f6dd49e63d7ec42d4af534e8dd749a8110344f024f43f001f034973d00f121fa5ee4b86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb91bbf74dca718fd9bffa01b2d23039ecc84a9ed172420d0313d6efab04cb2a3a84bf86a9ab6a70229cd9d522f423f6f623ecc03cdf74011c760c4b1975b61e"} 08:16:29 INFO - Running post-run listener: copy_logs_to_upload_dir 08:16:29 INFO - Copying logs to upload dir... 08:16:29 INFO - mkdir: /builds/slave/test/build/upload/logs 08:16:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.572738 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2016-04-11 08:16:29.206174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 08:16:29.209807) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47fde7baa31e70da2d6eb9848e3a5b1c9d254c5f514cc5638f19ef465f6dd49e63d7ec42d4af534e8dd749a8110344f024f43f001f034973d00f121fa5ee4b86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb91bbf74dca718fd9bffa01b2d23039ecc84a9ed172420d0313d6efab04cb2a3a84bf86a9ab6a70229cd9d522f423f6f623ecc03cdf74011c760c4b1975b61e"} build_url:https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/HVY0SYrYRJS1HeTwvCHeQg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/47fde7baa31e70da2d6eb9848e3a5b1c9d254c5f514cc5638f19ef465f6dd49e63d7ec42d4af534e8dd749a8110344f024f43f001f034973d00f121fa5ee4b86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cb91bbf74dca718fd9bffa01b2d23039ecc84a9ed172420d0313d6efab04cb2a3a84bf86a9ab6a70229cd9d522f423f6f623ecc03cdf74011c760c4b1975b61e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-11 08:16:29.238280) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:16:29.238619) ========= 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.8QDiRtOh6N/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.yxtf9OS74Q/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005129 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-11 08:16:29.288850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 08:16:29.289162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-11 08:16:29.289551) ========= ========= Total master_lag: 0.35 =========