builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1460237642.86 results: success (0) buildid: 20160409125141 builduid: 27d2af5c3e214c08ab19095e454cca50 revision: ef111ba6ddf3962149355da51fc6bb8caf2bfcaf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.864166) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.864860) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.865200) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005516 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.957628) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.957975) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.977540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:02.977849) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005283 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.028401) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.028890) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.032922) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.033537) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-09 14:34:03-- 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% 193M=0s 2016-04-09 14:34:03 (193 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093912 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.145510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.146019) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.026353 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:03.196849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-09 14:34:03.197335) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ef111ba6ddf3962149355da51fc6bb8caf2bfcaf --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 ef111ba6ddf3962149355da51fc6bb8caf2bfcaf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-09 14:34:03,272 truncating revision to first 12 chars 2016-04-09 14:34:03,272 Setting DEBUG logging. 2016-04-09 14:34:03,272 attempt 1/10 2016-04-09 14:34:03,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ef111ba6ddf3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-09 14:34:05,365 unpacking tar archive at: fx-team-ef111ba6ddf3/testing/mozharness/ program finished with exit code 0 elapsedTime=2.342537 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-09 14:34:05.561141) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:05.561999) ========= echo ef111ba6ddf3962149355da51fc6bb8caf2bfcaf in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ef111ba6ddf3962149355da51fc6bb8caf2bfcaf'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 ef111ba6ddf3962149355da51fc6bb8caf2bfcaf program finished with exit code 0 elapsedTime=0.005297 script_repo_revision: 'ef111ba6ddf3962149355da51fc6bb8caf2bfcaf' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:05.616184) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:05.616562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-09 14:34:05.629826) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-09 14:34:05.630193) ========= /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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:05 INFO - MultiFileLogger online at 20160409 14:34:05 in /builds/slave/test 14:34:05 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 14:34:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:05 INFO - {'append_to_log': False, 14:34:05 INFO - 'base_work_dir': '/builds/slave/test', 14:34:05 INFO - 'blob_upload_branch': 'Fx-Team', 14:34:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:05 INFO - 'branch': 'Fx-Team', 14:34:05 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:05 INFO - 'config_files': ('talos/mac_config.py',), 14:34:05 INFO - 'default_actions': ('clobber', 14:34:05 INFO - 'read-buildbot-config', 14:34:05 INFO - 'download-and-extract', 14:34:05 INFO - 'populate-webroot', 14:34:05 INFO - 'create-virtualenv', 14:34:05 INFO - 'install', 14:34:05 INFO - 'run-tests'), 14:34:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:05 INFO - 'download_minidump_stackwalk': True, 14:34:05 INFO - 'download_symbols': 'ondemand', 14:34:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:05 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:05 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:05 INFO - 'installer_path': 'installer.exe', 14:34:05 INFO - 'log_level': 'info', 14:34:05 INFO - 'log_name': 'talos', 14:34:05 INFO - 'log_to_console': True, 14:34:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:34:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:34:05 INFO - 'opt_config_files': (), 14:34:05 INFO - 'pip_index': False, 14:34:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:05 INFO - 'cmd': ('bash', 14:34:05 INFO - '-c', 14:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:05 INFO - 'enabled': True, 14:34:05 INFO - 'halt_on_failure': False, 14:34:05 INFO - 'name': 'check_screen_resolution'},), 14:34:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:05 INFO - 'cmd': ('bash', 14:34:05 INFO - '-c', 14:34:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:05 INFO - 'enabled': True, 14:34:05 INFO - 'halt_on_failure': False, 14:34:05 INFO - 'name': 'check_screen_resolution'},), 14:34:05 INFO - 'run_cmd_checks_enabled': True, 14:34:05 INFO - 'sps_profile': False, 14:34:05 INFO - 'sps_profile_interval': 0, 14:34:05 INFO - 'suite': 'dromaeojs', 14:34:05 INFO - 'system_bits': '32', 14:34:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:05 INFO - 'title': 't-yosemite-r7-0102', 14:34:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:05 INFO - 'use_talos_json': True, 14:34:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:05 INFO - 'work_dir': 'build'} 14:34:05 INFO - ##### 14:34:05 INFO - ##### Running clobber step. 14:34:05 INFO - ##### 14:34:05 INFO - Running pre-action listener: _resource_record_pre_action 14:34:05 INFO - Running main action method: clobber 14:34:05 INFO - rmtree: /builds/slave/test/build 14:34:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:07 INFO - Running post-action listener: _resource_record_post_action 14:34:07 INFO - ##### 14:34:07 INFO - ##### Running read-buildbot-config step. 14:34:07 INFO - ##### 14:34:07 INFO - Running pre-action listener: _resource_record_pre_action 14:34:07 INFO - Running main action method: read_buildbot_config 14:34:07 INFO - Using buildbot properties: 14:34:07 INFO - { 14:34:07 INFO - "project": "", 14:34:07 INFO - "product": "firefox", 14:34:07 INFO - "script_repo_revision": "production", 14:34:07 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:34:07 INFO - "repository": "", 14:34:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:34:07 INFO - "buildid": "20160409125141", 14:34:07 INFO - "pgo_build": "False", 14:34:07 INFO - "basedir": "/builds/slave/test", 14:34:07 INFO - "buildnumber": 647, 14:34:07 INFO - "slavename": "t-yosemite-r7-0102", 14:34:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 14:34:07 INFO - "platform": "yosemite_r7", 14:34:07 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:34:07 INFO - "branch": "fx-team", 14:34:07 INFO - "repo_path": "integration/fx-team", 14:34:07 INFO - "revision": "ef111ba6ddf3962149355da51fc6bb8caf2bfcaf", 14:34:07 INFO - "stage_platform": "macosx64", 14:34:07 INFO - "builduid": "27d2af5c3e214c08ab19095e454cca50", 14:34:07 INFO - "slavebuilddir": "test" 14:34:07 INFO - } 14:34:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:34:07 INFO - Running post-action listener: _resource_record_post_action 14:34:07 INFO - ##### 14:34:07 INFO - ##### Running download-and-extract step. 14:34:07 INFO - ##### 14:34:07 INFO - Running pre-action listener: _resource_record_pre_action 14:34:07 INFO - Running main action method: download_and_extract 14:34:07 INFO - mkdir: /builds/slave/test/build/tests 14:34:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:07 INFO - https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:34:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:09 INFO - Downloaded 1199 bytes. 14:34:09 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:34:09 INFO - Using the following test package requirements: 14:34:09 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:34:09 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:34:09 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:34:09 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'jsshell-mac.zip'], 14:34:09 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:34:09 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:34:09 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:34:09 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:34:09 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:34:09 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:34:09 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:34:09 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:34: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')]} 14:34:09 INFO - https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:10 INFO - Downloaded 18014556 bytes. 14:34:10 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'] 14:34:10 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 14:34:13 INFO - Return code: 0 14:34:13 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 14:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:34:13 INFO - https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:34:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:34:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:14 INFO - Downloaded 18014556 bytes. 14:34:14 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'] 14:34:14 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 14:34:18 INFO - Return code: 0 14:34:18 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')]} 14:34:18 INFO - https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:34:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:34:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:34:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:20 INFO - Downloaded 10841097 bytes. 14:34:20 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'] 14:34:20 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 14:34:20 INFO - Return code: 0 14:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:34:20 INFO - https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:34:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:34:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:34:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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 14:34:24 INFO - Downloaded 108757478 bytes. 14:34:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:34:24 INFO - mkdir: /builds/slave/test/properties 14:34:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:24 INFO - Contents: 14:34:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:34:25 INFO - Running post-action listener: _resource_record_post_action 14:34:25 INFO - Running post-action listener: set_extra_try_arguments 14:34:25 INFO - ##### 14:34:25 INFO - ##### Running populate-webroot step. 14:34:25 INFO - ##### 14:34:25 INFO - Running pre-action listener: _resource_record_pre_action 14:34:25 INFO - Running main action method: populate_webroot 14:34:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:25 INFO - '--tppagecycles', 14:34:25 INFO - '7'], 14:34:25 INFO - 'tests': ['tsvgm']}}, 14:34:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['damp', 'tps']}, 14:34:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'tests': ['damp', 'tps']}, 14:34:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['dromaeo_dom']}, 14:34:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['a11yr', 14:34:25 INFO - 'ts_paint', 14:34:25 INFO - 'tpaint', 14:34:25 INFO - 'sessionrestore', 14:34:25 INFO - 'sessionrestore_no_auto_restore', 14:34:25 INFO - 'tabpaint']}, 14:34:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['tsvgx', 14:34:25 INFO - 'tsvgr_opacity', 14:34:25 INFO - 'tart', 14:34:25 INFO - 'tscrollx', 14:34:25 INFO - 'cart']}, 14:34:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:25 INFO - 'tsvgr_opacity', 14:34:25 INFO - 'tart', 14:34:25 INFO - 'tscrollx', 14:34:25 INFO - 'cart']}, 14:34:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'talos_options': ['--disable-e10s'], 14:34:25 INFO - 'tests': ['tp5o']}, 14:34:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'tests': ['tp5o']}, 14:34:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'talos_options': ['--disable-e10s', 14:34:25 INFO - '--xperf_path', 14:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:25 INFO - 'tests': ['tp5n']}, 14:34:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:34:25 INFO - 'talos_options': ['--xperf_path', 14:34:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:25 INFO - 'tests': ['tp5n']}}, 14:34:25 INFO - 'talos.zip': {'path': '', 14:34:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:25 INFO - Running post-action listener: _resource_record_post_action 14:34:25 INFO - ##### 14:34:25 INFO - ##### Running create-virtualenv step. 14:34:25 INFO - ##### 14:34:25 INFO - Running pre-action listener: _resource_record_pre_action 14:34:25 INFO - Running main action method: create_virtualenv 14:34:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:25 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 14:34:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:25 INFO - Using real prefix '/tools/python27' 14:34:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:25 INFO - Installing distribute.............................................................................................................................................................................................done. 14:34:28 INFO - Installing pip.................done. 14:34:28 INFO - Return code: 0 14:34:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:34:28 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')]} 14:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:28 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')]} 14:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:28 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:28 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 14:34:28 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 14:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:28 INFO - 'HOME': '/Users/cltbld', 14:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:28 INFO - 'LOGNAME': 'cltbld', 14:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:28 INFO - 'MOZ_NO_REMOTE': '1', 14:34:28 INFO - 'NO_EM_RESTART': '1', 14:34:28 INFO - 'PAGER': '/bin/cat', 14:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:28 INFO - 'PWD': '/builds/slave/test', 14:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:28 INFO - 'SHELL': '/bin/bash', 14:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:28 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:28 INFO - 'USER': 'cltbld', 14:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:28 INFO - 'XPC_FLAGS': '0x0', 14:34:28 INFO - 'XPC_SERVICE_NAME': '0', 14:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:29 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 14:34:29 INFO - Cleaning up... 14:34:29 INFO - Return code: 0 14:34:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:29 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:29 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 14:34:29 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 14:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:29 INFO - 'HOME': '/Users/cltbld', 14:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:29 INFO - 'LOGNAME': 'cltbld', 14:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:29 INFO - 'MOZ_NO_REMOTE': '1', 14:34:29 INFO - 'NO_EM_RESTART': '1', 14:34:29 INFO - 'PAGER': '/bin/cat', 14:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:29 INFO - 'PWD': '/builds/slave/test', 14:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:29 INFO - 'SHELL': '/bin/bash', 14:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:29 INFO - 'USER': 'cltbld', 14:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:29 INFO - 'XPC_FLAGS': '0x0', 14:34:29 INFO - 'XPC_SERVICE_NAME': '0', 14:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:29 INFO - Downloading/unpacking psutil>=0.7.1 14:34:29 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 14:34:29 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 14:34:29 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 14:34:29 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 14:34:29 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 14:34:29 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 14:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:34:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:32 INFO - Installing collected packages: psutil 14:34:32 INFO - Running setup.py install for psutil 14:34:32 INFO - building 'psutil._psutil_osx' extension 14:34:32 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 14:34:32 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 14:34:32 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 14:34:33 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 14:34:33 INFO - building 'psutil._psutil_posix' extension 14:34:33 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 14:34:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:34:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:34:33 INFO - ^ 14:34:33 INFO - 1 warning generated. 14:34:33 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 14:34:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:34:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:34:33 INFO - Successfully installed psutil 14:34:33 INFO - Cleaning up... 14:34:33 INFO - Return code: 0 14:34:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:33 INFO - 'HOME': '/Users/cltbld', 14:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:33 INFO - 'LOGNAME': 'cltbld', 14:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:33 INFO - 'MOZ_NO_REMOTE': '1', 14:34:33 INFO - 'NO_EM_RESTART': '1', 14:34:33 INFO - 'PAGER': '/bin/cat', 14:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:33 INFO - 'PWD': '/builds/slave/test', 14:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:33 INFO - 'SHELL': '/bin/bash', 14:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:33 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:33 INFO - 'USER': 'cltbld', 14:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:33 INFO - 'XPC_FLAGS': '0x0', 14:34:33 INFO - 'XPC_SERVICE_NAME': '0', 14:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:34:33 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 14:34:33 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 14:34:33 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 14:34:33 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 14:34:33 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 14:34:33 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 14:34:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:34:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:34:36 INFO - Installing collected packages: mozsystemmonitor 14:34:36 INFO - Running setup.py install for mozsystemmonitor 14:34:36 INFO - Successfully installed mozsystemmonitor 14:34:36 INFO - Cleaning up... 14:34:36 INFO - Return code: 0 14:34:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:34:36 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')]} 14:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:36 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')]} 14:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:36 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:36 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 14:34:36 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 14:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:36 INFO - 'HOME': '/Users/cltbld', 14:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:36 INFO - 'LOGNAME': 'cltbld', 14:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:36 INFO - 'MOZ_NO_REMOTE': '1', 14:34:36 INFO - 'NO_EM_RESTART': '1', 14:34:36 INFO - 'PAGER': '/bin/cat', 14:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:36 INFO - 'PWD': '/builds/slave/test', 14:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:36 INFO - 'SHELL': '/bin/bash', 14:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:36 INFO - 'USER': 'cltbld', 14:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:36 INFO - 'XPC_FLAGS': '0x0', 14:34:36 INFO - 'XPC_SERVICE_NAME': '0', 14:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:36 INFO - Downloading/unpacking blobuploader==1.2.4 14:34:36 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 14:34:36 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 14:34:36 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 14:34:36 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 14:34:36 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 14:34:36 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 14:34:39 INFO - Downloading blobuploader-1.2.4.tar.gz 14:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:34:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:34:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:39 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 14:34:40 INFO - Downloading docopt-0.6.1.tar.gz 14:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:34:40 INFO - Installing collected packages: blobuploader, requests, docopt 14:34:40 INFO - Running setup.py install for blobuploader 14:34:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:34:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:34:40 INFO - Running setup.py install for requests 14:34:41 INFO - Running setup.py install for docopt 14:34:41 INFO - Successfully installed blobuploader requests docopt 14:34:41 INFO - Cleaning up... 14:34:41 INFO - Return code: 0 14:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:41 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:41 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 14:34:41 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 14:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:41 INFO - 'HOME': '/Users/cltbld', 14:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:41 INFO - 'LOGNAME': 'cltbld', 14:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:41 INFO - 'MOZ_NO_REMOTE': '1', 14:34:41 INFO - 'NO_EM_RESTART': '1', 14:34:41 INFO - 'PAGER': '/bin/cat', 14:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:41 INFO - 'PWD': '/builds/slave/test', 14:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:41 INFO - 'SHELL': '/bin/bash', 14:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:41 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:41 INFO - 'USER': 'cltbld', 14:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:41 INFO - 'XPC_FLAGS': '0x0', 14:34:41 INFO - 'XPC_SERVICE_NAME': '0', 14:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bc8o72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-V7KAVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VOHUe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-cGftYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:41 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jQvjyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TDn0GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UKbcIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xsTz_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Xpsuss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wA7b73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RR7sIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-BTv3OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-adswZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:42 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-25eU87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-a5yyET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-f4ZlgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:43 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-pF6Ilf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:34:43 INFO - Running setup.py install for manifestparser 14:34:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for mozcrash 14:34:43 INFO - Running setup.py install for mozdebug 14:34:43 INFO - Running setup.py install for mozdevice 14:34:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:34:43 INFO - Running setup.py install for mozfile 14:34:44 INFO - Running setup.py install for mozhttpd 14:34:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Running setup.py install for mozinfo 14:34:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Running setup.py install for mozInstall 14:34:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Running setup.py install for mozleak 14:34:44 INFO - Running setup.py install for mozlog 14:34:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Running setup.py install for moznetwork 14:34:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:34:44 INFO - Running setup.py install for mozprocess 14:34:45 INFO - Running setup.py install for mozprofile 14:34:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:34:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:34:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:34:45 INFO - Running setup.py install for mozrunner 14:34:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:34:45 INFO - Running setup.py install for mozscreenshot 14:34:45 INFO - Running setup.py install for moztest 14:34:45 INFO - Running setup.py install for mozversion 14:34:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:34:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:34:45 INFO - Cleaning up... 14:34:45 INFO - Return code: 0 14:34:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34:45 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')]} 14:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:45 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')]} 14:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:45 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:45 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 14:34:45 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 14:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:45 INFO - 'HOME': '/Users/cltbld', 14:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:45 INFO - 'LOGNAME': 'cltbld', 14:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:45 INFO - 'MOZ_NO_REMOTE': '1', 14:34:45 INFO - 'NO_EM_RESTART': '1', 14:34:45 INFO - 'PAGER': '/bin/cat', 14:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:45 INFO - 'PWD': '/builds/slave/test', 14:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:45 INFO - 'SHELL': '/bin/bash', 14:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:45 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:45 INFO - 'USER': 'cltbld', 14:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:45 INFO - 'XPC_FLAGS': '0x0', 14:34:45 INFO - 'XPC_SERVICE_NAME': '0', 14:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-io_VYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Qeo_S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-YsLCrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-clL6j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4HIVeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Wt4HGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tFlZcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:34:46 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)) 14:34:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:34:46 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ZCAptI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-vW25V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-aKaFiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zczLP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-j0q044-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-UL8BqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jPkqVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-e8pcvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-YJg6wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:34:47 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)) 14:34:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:34:47 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-e46LK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:34:47 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)) 14:34:47 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)) 14:34:47 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)) 14:34:47 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)) 14:34:47 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)) 14:34:47 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)) 14:34:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:34:47 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 14:34:47 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 14:34:47 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 14:34:47 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 14:34:47 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 14:34:47 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 14:34:50 INFO - Downloading blessings-1.6.tar.gz 14:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:34:50 INFO - Installing collected packages: blessings 14:34:50 INFO - Running setup.py install for blessings 14:34:50 INFO - Successfully installed blessings 14:34:50 INFO - Cleaning up... 14:34:50 INFO - Return code: 0 14:34:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:50 INFO - Reading from file tmpfile_stdout 14:34:50 INFO - Current package versions: 14:34:50 INFO - blessings == 1.6 14:34:50 INFO - blobuploader == 1.2.4 14:34:50 INFO - docopt == 0.6.1 14:34:50 INFO - manifestparser == 1.1 14:34:50 INFO - mozInstall == 1.12 14:34:50 INFO - mozcrash == 0.17 14:34:50 INFO - mozdebug == 0.1 14:34:50 INFO - mozdevice == 0.48 14:34:50 INFO - mozfile == 1.2 14:34:50 INFO - mozhttpd == 0.7 14:34:50 INFO - mozinfo == 0.9 14:34:50 INFO - mozleak == 0.1 14:34:51 INFO - mozlog == 3.1 14:34:51 INFO - moznetwork == 0.27 14:34:51 INFO - mozprocess == 0.22 14:34:51 INFO - mozprofile == 0.28 14:34:51 INFO - mozrunner == 6.11 14:34:51 INFO - mozscreenshot == 0.1 14:34:51 INFO - mozsystemmonitor == 0.0 14:34:51 INFO - moztest == 0.7 14:34:51 INFO - mozversion == 1.4 14:34:51 INFO - psutil == 3.1.1 14:34:51 INFO - requests == 1.2.3 14:34:51 INFO - wsgiref == 0.1.2 14:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:51 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 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:51 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 14:34:51 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 14:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:51 INFO - 'HOME': '/Users/cltbld', 14:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:51 INFO - 'LOGNAME': 'cltbld', 14:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:51 INFO - 'MOZ_NO_REMOTE': '1', 14:34:51 INFO - 'NO_EM_RESTART': '1', 14:34:51 INFO - 'PAGER': '/bin/cat', 14:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:51 INFO - 'PWD': '/builds/slave/test', 14:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:51 INFO - 'SHELL': '/bin/bash', 14:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:51 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:51 INFO - 'USER': 'cltbld', 14:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:51 INFO - 'XPC_FLAGS': '0x0', 14:34:51 INFO - 'XPC_SERVICE_NAME': '0', 14:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 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)) 14:34:51 INFO - Cleaning up... 14:34:51 INFO - Return code: 0 14:34:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:34: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')]} 14:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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')]} 14:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34: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', 'jsonschema'] in /builds/slave/test/build 14:34: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 jsonschema 14:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:51 INFO - 'HOME': '/Users/cltbld', 14:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:51 INFO - 'LOGNAME': 'cltbld', 14:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:51 INFO - 'MOZ_NO_REMOTE': '1', 14:34:51 INFO - 'NO_EM_RESTART': '1', 14:34:51 INFO - 'PAGER': '/bin/cat', 14:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:51 INFO - 'PWD': '/builds/slave/test', 14:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:51 INFO - 'SHELL': '/bin/bash', 14:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:51 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:51 INFO - 'USER': 'cltbld', 14:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:51 INFO - 'XPC_FLAGS': '0x0', 14:34:51 INFO - 'XPC_SERVICE_NAME': '0', 14:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:51 INFO - Downloading/unpacking jsonschema 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:34:53 INFO - Downloading/unpacking functools32 (from jsonschema) 14:34:53 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 14:34:53 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 14:34:53 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 14:34:53 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 14:34:53 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 14:34:53 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 14:34:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:34:54 INFO - warning: no files found matching '*.txt' 14:34:54 INFO - no previously-included directories found matching 'build' 14:34:54 INFO - no previously-included directories found matching 'dist' 14:34:54 INFO - no previously-included directories found matching '.git*' 14:34:54 INFO - Installing collected packages: jsonschema, functools32 14:34:54 INFO - Running setup.py install for functools32 14:34:54 INFO - warning: no files found matching '*.txt' 14:34:54 INFO - no previously-included directories found matching 'build' 14:34:54 INFO - no previously-included directories found matching 'dist' 14:34:54 INFO - no previously-included directories found matching '.git*' 14:34:54 INFO - Successfully installed jsonschema functools32 14:34:54 INFO - Cleaning up... 14:34:54 INFO - Return code: 0 14:34:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:34:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1078d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1078e2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f893b472970>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, '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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 14:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:34:54 INFO - 'HOME': '/Users/cltbld', 14:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:34:54 INFO - 'LOGNAME': 'cltbld', 14:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:34:54 INFO - 'MOZ_NO_REMOTE': '1', 14:34:54 INFO - 'NO_EM_RESTART': '1', 14:34:54 INFO - 'PAGER': '/bin/cat', 14:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:34:54 INFO - 'PWD': '/builds/slave/test', 14:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:34:54 INFO - 'SHELL': '/bin/bash', 14:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:34:54 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:34:54 INFO - 'USER': 'cltbld', 14:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:34:54 INFO - 'XPC_FLAGS': '0x0', 14:34:54 INFO - 'XPC_SERVICE_NAME': '0', 14:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:34:54 INFO - Downloading/unpacking flake8 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34: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 14:34:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:34:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:34:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:34:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:34:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:34:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:34:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:34:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:34:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:34:58 INFO - no previously-included directories found matching 'docs/_build' 14:34:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:34:58 INFO - Running setup.py install for pep8 14:34:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:34:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:34:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:34:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:34:58 INFO - no previously-included directories found matching 'docs/_build' 14:34:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:34:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:34:58 INFO - Cleaning up... 14:34:58 INFO - Return code: 0 14:34:58 INFO - Running post-action listener: _resource_record_post_action 14:34:58 INFO - Running post-action listener: _start_resource_monitoring 14:34:59 INFO - Starting resource monitoring. 14:34:59 INFO - ##### 14:34:59 INFO - ##### Running install step. 14:34:59 INFO - ##### 14:34:59 INFO - Running pre-action listener: _resource_record_pre_action 14:34:59 INFO - Running main action method: install 14:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:34:59 INFO - Reading from file tmpfile_stdout 14:34:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:34:59 INFO - Reading from file tmpfile_stdout 14:34:59 INFO - Output received: 14:34:59 INFO - Usage: mozinstall [options] installer 14:34:59 INFO - Options: 14:34:59 INFO - -h, --help show this help message and exit 14:34:59 INFO - -d DEST, --destination=DEST 14:34:59 INFO - Directory to install application into. [default: 14:34:59 INFO - "/builds/slave/test"] 14:34:59 INFO - --app=APP Application being installed. [default: firefox] 14:34:59 INFO - mkdir: /builds/slave/test/build/application 14:34:59 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'] 14:34:59 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 14:35:33 INFO - Reading from file tmpfile_stdout 14:35:33 INFO - Output received: 14:35:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:35:33 INFO - Running post-action listener: _resource_record_post_action 14:35:33 INFO - ##### 14:35:33 INFO - ##### Running run-tests step. 14:35:33 INFO - ##### 14:35:33 INFO - Running pre-action listener: _resource_record_pre_action 14:35:33 INFO - Running main action method: run_tests 14:35:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:33 INFO - 2016-04-09 14:35:33.417 screenresolution[1642:7616] starting screenresolution argv=screenresolution get 14:35:33 INFO - 2016-04-09 14:35:33.419 screenresolution[1642:7616] Display 0: 1600x1200x32@60 14:35:33 INFO - 2016-04-09 14:35:33.425 screenresolution[1643:7618] starting screenresolution argv=screenresolution list 14:35:33 INFO - Available Modes on Display 0 14:35:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:33 INFO - Intel Iris: 14:35:33 INFO - Chipset Model: Intel Iris 14:35:33 INFO - Type: GPU 14:35:33 INFO - Bus: Built-In 14:35:33 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:33 INFO - Vendor: Intel (0x8086) 14:35:33 INFO - Device ID: 0x0a2e 14:35:33 INFO - Revision ID: 0x0009 14:35:33 INFO - Displays: 14:35:33 INFO - Display: 14:35:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:33 INFO - Display Serial Number: 1600x1200 60 14:35:33 INFO - Main Display: Yes 14:35:33 INFO - Mirror: Off 14:35:33 INFO - Online: Yes 14:35:33 INFO - Rotation: Supported 14:35:33 INFO - Return code: 0 14:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:33 INFO - Python 2.7.3 14:35:33 INFO - Return code: 0 14:35:33 INFO - grabbing minidump binary from tooltool 14:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:35:33 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 0x107771e00>, '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 0x10759adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10776cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:33 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 14:35:33 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 14:35:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:33 INFO - Return code: 0 14:35:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:35:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:35:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:35:34 INFO - Return code: 0 14:35:34 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/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 14:35:34 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/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 14:35:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hXV5XwBnlD/Render', 14:35:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:34 INFO - 'HOME': '/Users/cltbld', 14:35:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:34 INFO - 'LOGNAME': 'cltbld', 14:35:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:34 INFO - 'MOZ_NO_REMOTE': '1', 14:35:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:34 INFO - 'NO_EM_RESTART': '1', 14:35:34 INFO - 'PAGER': '/bin/cat', 14:35:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:34 INFO - 'PWD': '/builds/slave/test', 14:35:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:34 INFO - 'SHELL': '/bin/bash', 14:35:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GX86Hd6KSK/Listeners', 14:35:34 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 14:35:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:34 INFO - 'USER': 'cltbld', 14:35:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:34 INFO - 'XPC_FLAGS': '0x0', 14:35:34 INFO - 'XPC_SERVICE_NAME': '0', 14:35:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:34 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/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 14:35:35 INFO - mozversion application_buildid: 20160409125141 14:35:35 INFO - mozversion application_changeset: ef111ba6ddf3962149355da51fc6bb8caf2bfcaf 14:35:35 INFO - mozversion application_display_name: Nightly 14:35:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:35 INFO - mozversion application_name: Firefox 14:35:35 INFO - mozversion application_remotingname: firefox 14:35:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:35:35 INFO - mozversion application_vendor: Mozilla 14:35:35 INFO - mozversion application_version: 48.0a1 14:35:35 INFO - mozversion platform_buildid: 20160409125141 14:35:35 INFO - mozversion platform_changeset: ef111ba6ddf3962149355da51fc6bb8caf2bfcaf 14:35:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:35:35 INFO - mozversion platform_version: 48.0a1 14:35:35 INFO - using testdate: 1460237735 14:35:35 INFO - actual date: 1460237735 14:35:35 INFO - starting webserver on 'localhost:49270' 14:35:35 INFO - SUITE-START | Running 2 tests 14:35:35 INFO - TEST-START | dromaeo_css 14:35:35 INFO - operating with platform_type : mac_ 14:35:35 INFO - Initialising browser for dromaeo_css test... 14:35:35 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpAsZ3fI/profile http://localhost:49270/getInfo.html) 14:35:37 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 14:35:37 INFO - PROCESS | 1661 | colorDepth:24 14:35:37 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 14:35:37 INFO - PROCESS | 1661 | __metrics 14:35:37 INFO - PROCESS | 1661 | 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" 14:35:37 ERROR - PROCESS | 1661 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:35:38 INFO - TEST-INFO | 1661: exit 0 14:35:38 INFO - Browser initialized. 14:35:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:38 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpAsZ3fI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:50 INFO - PROCESS | 1663 | RSS: Main: 237355008 14:35:50 INFO - PROCESS | 1663 | 14:36:41 INFO - PROCESS | 1663 | 1460237801040 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] 14:38:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:38:52 INFO - PROCESS | 1663 | RSS: Main: 334286848 14:38:52 INFO - PROCESS | 1663 | 14:41:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:41:56 INFO - PROCESS | 1663 | RSS: Main: 377966592 14:41:56 INFO - PROCESS | 1663 | 14:44:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:44:58 INFO - PROCESS | 1663 | RSS: Main: 375308288 14:44:58 INFO - PROCESS | 1663 | 14:48:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:48:01 INFO - PROCESS | 1663 | RSS: Main: 334807040 14:48:01 INFO - PROCESS | 1663 | 14:51:04 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:51:05 INFO - PROCESS | 1663 | RSS: Main: 337375232 14:51:05 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:54:08 INFO - PROCESS | 1663 | RSS: Main: 384479232 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | __start_tp_report 14:54:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 14:54:08 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 14:54:08 INFO - PROCESS | 1663 | |i|pagename|runs| 14:54:08 INFO - PROCESS | 1663 | |0;dojo.html;3360.3279344131174;3411.62472128066;3447.620761716209;3453.223024819416;3483.8432270547823;5565.109582466806;5660.575456840733;5664.178694089354;5670.432956704328;5705.372409035008;5675.801346952858;5703.800366987156;5843.4156584341545;5896.5282777377815;5913.497352725013;5098.847034588968;5129.6665716728385;5162.457941916101;5173.948260517384;5294.973525132388;4342.522322544518;5261.605379596526;5298.708571028592;5325.946740532584;5360.758765855546;5082.949170508285;5130.050940576006;5189.532942035235;5190.221466779975;5251.501107394792;5012.398512178525;5026.246063090565;5029.974850125763;5098.056859480971;5106.412762532282;4935.407751069894;5023.14606516893;5037.0429618372755;5037.773300201463;5041.495850414965;5406.783728650849;5448;5495.258140151069;5603.831885043455;5632.295963004624;6198.349173336825;6213.03697926822;6229.127922090911;6236.126942228047;6246.781362652331;6219.09823075656;6268.15379923709;6272.027835685476;6292.244930608311;6309.779157729457;5597.496225339698;5713.200151978726;5713.600047996601;5752.741126649311;5756.971215143939;6115.6330620162935;6173.629582225081;6218.782342618078;6263.4362907338555;6265.874682506415;5083.491650834887;5347.171188465794;6044.123602077762;6099.2985806632805;6107.175531303306;5422.40353561108;6198.81403557894;6240.438360547572;6243.96878015607;6247.9062814057825;6096.817095487142;6125.509959203253;6164.260288765377;6173.135760993465;6228.159198508234;6214.751409943552;6219.315875253718;6238.968805156036;6248.062790581449;6256.499480041586;4167.854125105607;4885.316055752198;4885.560299573055;4926.014797040606;4926.113299606033;3899.9610003900166;3960.346542820402;4314.245007123741;4356.9128617428105;4448.399466072104;5616.971915140398;5658.151277308437;5667.688277144714;5669.40471250521;5679.943200568024;6249.156363890907;6267.4986001119805;6293.811185664437;6308.3060863305;6309.274433440213;5659.943400566024;5688.23208866806;5690.5447564194765;5703.600747947604;5731.914021289684;5269.736513174326;5298.708571028554;5344.091504444254;5383.111786555174;5402.405735369106;5335.759890804923;6248.625082495065;6288.748450061947;6312.242530896322;6318.71565779541;6223.621359126879;6248.281447633581;6261.65560894137;6266.248050234001;6286.15136956505;5467.617266791445;6220.284667263322;6247.750089996531;6263.906041409291;6321.11504389395;6147.108669243024;6148.047052706837;6151.108089327112;6167.753289868535;6167.907481387872;6032.366601506778;6219.284782250099;6246.718897649525;6247.656378899204;6266.874662506815;5786.218860453953;5945.34601193877;6064.211652485149;6069.2716873975405;6103.389661033861;5977.790777322773;5994.850128746816;5997.460228579449;6008.1588577598295;6034.969825150846;5772.307323121252;5879.853003674943;5895.322037965689;5898.233229680286;5908.497777688945;6031.125486804476;6083.695815209133;6106.297775755845;6120.571559990936;6120.816375508742;5846.473817356458;5922.318933322723;5937.643741375531;5970.58205925581;6008.068749343859 14:54:08 INFO - PROCESS | 1663 | |1;ext.html;499.6078078708215;501.2206019639459;514.6448950224345;527.7229454536368;531.449949302472;29349.55975660364;37676.05809854752;37750.43374349387;37758;37814.62185378146;39951.00122496932;40523.98690032751;40562;40571;40698.79650601743;9239.6304147834;9489.478078705668;9489.81020379592;9494;9504.809903801919;9315.860262096074;9489.952550237274;9490.71527854162;9573.473458959754;9595.23238140947;9504.904950950506;9607.615695372211;9617.663381781638;9630.422174669542;9651.131398174162;9536.809263814719;9612.327137100407;9612.423254604746;9612.567434465465;9613.855792163053;9458.054194580556;9484.19384352331;9568.043195680446;9590.08894155054;9596.95201523988;38947.61052389497;39299;39343.016424589325;39362.21275574501;39412.21175576472;3203.2472368993267;3325.6840600142946;3359.9160020999425;3366.9831650841834;3410.454327307644;27939.860300698365;28234.011809586566;28463.430731385462;28521.286967825763;28530.429391412265;2678.34380576758;2733.9179824605294;2768.418632087244;2838.205302515278;2911.980806717653;465230.34769652545;465615.42268907186;466900;466945;467696;57595;57821.42178578245;58106.54733631693;58335.5416114592;58508.41491585115;61493.69253153705;64905;66716;66802.33197668058;66993.66503167551;16025.839741602435;16253.918730406509;16268.430604928772;16274.75587866183;16307.429239976782;12467.314297713712;12517;12523.686907827378;12526.81209781854;12538.561150359694;18710.8773473592;18723.90638046801;18742;18752.781069230456;19207.32774352891;7123.679434425463;7172.928270717226;7488.588127652923;7503.962480187564;7994.68021279154;869.5217630303308;894.2220268366563;936.7330310861508;944.9527523623791;1158.3860553906443;28397;28916.277093072422;29023.896637323636;29298.560521592193;29641.703582964325;1039.1219419590434;1055.1137044882182;1084.3168803653805;1103.4813637590319;1106.6624679472677;14667.633309167357;14780.704385912222;14898.329575169144;15175.571908494589;15195.316210770541;604025;604196;612029;612063;613253;57800.42199577951;58570;58653;58785.11822322669;58844.41155588475;1292.2246652008907;1414.420087764012;1415.610707055568;1461.7149655817013;1472.955811325662;27805.582916256677;27809.58285625677;28326.433471330045;28570.85716571397;28620.42759144847;44578.3313250295;45168.77415612901;45181.870453237614;45251.77374113108;45277.773611131735;339762;350616;351200;351773;353189;22679;25376.492470150126;25567.977280908555;25848.612270816328;26158.607620886083;40277.99305017398;40373.798131009156;40506;40959.79520102381;41478.37782433326;33851.83074084712;34280.971570851914;34409.31181376308;34868.302633946674;35333.76331828374;34958.30083398369;35085.47371789374;35659;35701.28597427985;35769.28461430809;35118.946431607095;35220.823895880356;35320.82339588286;35784.46323305101;36102.09744756297;23996.64005039891;30295.697043029286;30427.54358684666;30454.93407730719;30500.08499745011;22812.42968925724;23159.421014474774;23287.53424931458;23452.882735586212;23567.882160589088 14:54:08 INFO - PROCESS | 1663 | |2;jquery.html;383.39423710537346;385.610533361305;385.85337571722744;399.3490610305202;405.67140616100977;19290.131944062516;20424.387268381935;20436.182552697894;20445.591088178247;20748.170073197052;12000.859918307748;12102.334371609559;12181.20822146562;12344.753104937918;12375.876241237585;5289.841304760854;5450.100733379008;5497.890042199154;5498.972505137469;5510.8071217507395;3886.145048089416;4151.14901445203;5832.679202643874;6158.353372895848;6164.876702465948;6047.304559975615;6143.907841382361;6145.477634401082;6150.354212807658;6160.5687601867885;4839.419269687624;5933.317668468138;6016.819495415145;6027.698615069229;6029.457348838604;3753.2681127180213;5592.7762889484775;5999.340072592011;5999.820005399845;6017.7592896284095;13729.382177802023;13845.861541384558;17801.910990445096;26443.206703798918;26486;1983.6826107822824;2047.2936836791282;2106.0417510033053;2189.3322536626324;2723.8695941184383;9583.616655333848;10177.440240786755;10204.795904081877;10394.376337419779;10455.94772026135;1757.200473784425;1765.3431585463923;1782.073321872632;1784.687679656068;1787.1332403784154;122993;127167.36416317952;127718;127919;129374;10820.13438924884;11674.824877626843;11707.414629268673;11863.644090677293;11896.464659090361;15364;15478;15478.5356439307;15521.922390387976;15547.611309717122;8425.668532946911;8602.268807151462;8607.870881936777;8703.606508210292;8743.907011623547;6409.775657851953;8166.1833816619055;8389.664413423394;8393.160683931557;8503;3889.813606849881;4610.515895830957;4642.3500709900645;4679.391679081766;4687.929681054787;1769.646070785848;1830.1355692815735;1833.0930960783392;1976.160131943947;1990.7710613279369;887.5163036145316;916.8991410944791;964.0407794244771;1031.6595523477235;1074.3446497636435;19360.128794204295;19628.41114766531;19907.60184796296;20208.29270975509;20255.189792408433;930.6277489004317;942.1464726352518;965.2471072563412;1005.5374527717186;1012.4532752313816;7844.529328240324;9135.54322283883;10401.375917444826;10570.894291057144;10639.361638301727;524880;620037;630286;634523;643132.490362835;71509.64245178844;74702.8794568082;108637.96344438718;132172.33913830368;138283.30858345644;1029.897010298964;1035.5236591168148;1057.2599180573475;1077.369738702852;1085.1644233939821;17452.95282283067;17726.379576714753;17730.73403898968;17787.145625636866;18136.546586335448;51534.48465515447;51893.481065190375;52957;53653.7317313411;53804.65488362822;77603.61198194198;78492.60753696195;79206.20793792218;79381;82467;7942.375130319392;8027.067326507122;8066.014645501029;8201.58992050407;8261.17388261169;8512.70205542803;9064.546772661472;10414.59402980588;11250.887491124984;12438.564650237198;5004.149294619996;9355.48544830041;10768;10838.729031774268;11086.279391839827;10257.33327333721;10655.360678359324;10843.240973131806;10938.56245750161;11094.389808560607;9900.356476828983;10586.629467968893;11449.656510304705;11553;11606.88393116058;8071.031476222891;8256.25693687547;8280.171982801672;8381.664733410595;8427.915720842713;9929.453880036668;11009.2843965142;11263.155263355446;11352.716182095513;11384.544618215179 14:54:08 INFO - PROCESS | 1663 | |3;mootools.html;1388.8958328125393;1580.0914474177348;1582.841715828417;1836.0911348882305;1985.1860737097793;7875.251851074146;8653.653853845846;8869.113088691127;8877.334199935014;8893.333000025008;8477.830443391129;8727.694530691428;8731.083236260181;8734.432261902972;8734.563271836414;2156.7735387784214;2462.2367066209486;2499.1627804685454;2500.1624455807237;2507.109975958527;2501.8874150663264;2526.4568117854656;2529.203300960201;2531.1520640585427;2532.7720505154534;2347.730011048734;2350.4358953851124;2350.9412264693347;2352.4354155002848;2416.565018296706;2460.4463995601027;2472.950540989179;2480.578301688717;2482.453860150773;2482.8758562071826;2448.008556534606;2461.1878080233478;2471.221565206954;2480.962785558218;2485;8567.914320856775;8733.170348816851;8736.432131911406;8737.825243495094;8741.082186370466;5171.637985341028;5362.597805164628;5366.087765079907;5376.11294136467;5404.702741349224;3485.128717820545;3501.142220156078;3513.0690367052753;3548.3790336690977;3559.074640593464;1000.4147573669412;1004.4626125023151;1008.9747756306077;1016.2327442780727;1024.9500998003991;11452.141089418326;11455.770884582345;11458.770824583462;11470.541178352856;11489.540418383254;4682.461516925598;4762.404699412574;4818.416624271144;4892.975535122301;4910.116179087727;9782.9021709782;9809.656662016796;9825.508724563742;9834.459104749307;9840.212782977345;5350.357957045179;5358.27663265462;5362.678239305654;5401.216823560561;5405.891882162335;4342.457192850894;4505.48186958504;4709.646776491777;4824.807007719652;4825.541573550507;3949.5063117110362;3980.24375368679;4046.0289530512464;4118.258713431611;4119.608637179464;1319.1359659423092;1330.4279159961309;1331.0749029424458;1343.06656873472;1347.158026233604;1329.9202047877159;1332.8667133286594;1358.7893876449166;1362.9114107582975;1396.1692792788274;7943.443958922935;8080.55556944362;8127.349812015024;8145.633446494922;8158.4289099762445;501.3732833957553;512.6898226572944;516.7752027867889;517.735954663117;522.5323335614604;6211.9068213976825;6249.531285153632;6336.556441049082;6361.840953976188;6367.681615919186;10231.181505479544;10569.735756606146;10573.365598064142;10675.83986240207;10725.981031801966;9965.850512242323;10553.314034587727;10560.260781745204;10560.894391056145;10630.840537391945;7936.563489008045;8005.599720013976;8047.919520804717;8089.514629122272;8121.75634730959;8005.9599702001115;8168.387370947084;8208.179182081743;8246.257836794717;8249.711260105867;9479.431234125974;9517.42895426249;9670.99545601288;9695.369800962915;9893.307468477138;9818.410895346302;10019.749506262402;10111.39331640104;10175.796484070424;10273.640422585173;6427.3999320319235;6791.422729068085;7366.594837284001;7527.698892044257;7672.0409948756405;8246.711365102192;8252.793680158044;8331.541765202972;8341.12418196105;8362.832743345221;6987.650617469005;7302.671379788028;7305.780826575211;7391.519551229153;7502.062242219723;6975.128108986377;7200.459965502503;7218.133823941161;7292.088488938883;7300.853982920418;7698.576578288248;7703.998480197539;7720.150783413932;7734.961325193338;7738.41961852852;6934.514583979275;6940.375366217065;7029.26192749754;7046.330598593126;7064.187618423742;7059.929400706133;7157.033800437082;7173;7182.676779544829;7234.5659260444545 14:54:08 INFO - PROCESS | 1663 | |4;prototype.html;311.6384993407646;315.1035304558531;322.99192520186995;324.36748340735573;325.97968359036213;4977.825776097838;5361.51746342829;5907.105518296036;5954.672493012882;5999.280086389639;5501.174823776436;5877.383719477146;5882.970585147068;5914.467697907187;5915.722446857958;4037.899052523696;4169.937450938223;4314.389794174526;4419.182451246522;4432.20220360335;4421.4694236691485;4446.799894004761;4474.574915383034;4482.775861206943;4487.461504619434;4436.179306828231;4452.554744525538;4454.48773391061;4482.551744825508;4495.078508905666;3924;4190.266703326905;4204.411382406451;4466.062126953344;4477.776111194444;3802.0874990002476;3804.90487737806;3816.6755825754844;3816.923661526782;3840.6927445804267;5631.690257035862;5640.182173584848;5644.689542075184;5668.089018577169;5669.716514174274;4526.705764125321;4887.657863949525;5060.544550990392;5088.4148322942965;5162.664426812245;5504.752286147133;5868.559858010666;6191.254291153877;6192.783252586138;6197.380261973812;4191.72753771007;4209.7474151551005;4217.283061879488;4222.788860556991;4231;5060.2156665716875;5115.488451154892;6286.868363694533;6307.148534947769;6538.117354157175;3666.7433279670167;3931.66580840626;4040.6363427291685;4293.2057569349145;4294.935575966363;4189.476315460567;4362.476502819619;4380.408644832971;4388.166248412791;4389.868303950887;3877.922441551153;4451.109778044404;5074.23886417033;5075.365579302587;5097.566706829961;6137.202163718688;6210.347913469111;6212.285587157535;6231.345708700612;6242.875142497124;1369.4795977528474;1429.9499517517045;1459.2120255062148;1461.5396150212862;1463.2464280895347;804.1476035402492;934.2385955446425;948.7059011706393;953.9570719317647;959.9616015359308;4954.578860796801;5763.279590051244;5788.27646544182;5792.189093526909;5808.215890854681;5635.67495177847;5669.399931043817;6427.453666438311;6435.903461448082;6449.419552240321;5575.1915972184615;5747.770089196385;5812.895549845516;5825.563082768809;5863.944489991757;2979.8361090139815;3370.97185358468;3377.382528540352;3389.18659521713;3398.805123184199;5308.442613525602;5642.6332288401945;5652.925944070614;6660.966695166493;6678.866422671616;6015.729292181863;6133.264008318941;6328.746850125944;6575.44108750752;6580.243272023778;5356.919646205232;5801.3038435388025;5813.302403711582;6369.522285828489;6671.232808227019;6052.303985041776;6372.921330348673;6391.680415979089;6396.392342727433;6419.614823110628;5192.480751924928;5735.655860648374;6065.72704228302;6313.873722525615;6318.147050148171;6339.9683001586545;6506.804795856132;6572.934270657232;6628.933710662832;6787.423069039187;4188.811503482411;4198.845317537702;4199.559046300216;4201.810918508613;4207.242696314693;5428.402875683751;5646.407127251579;6151.138840562236;6434.806955791334;6506.3818937200895;6199.411055949678;6207.34822843613;6216.875662486635;6221.4089661482085;6239.719212635351;5222;5742.253507044057;6162.322144564184;6205.317415084427;6209.782657606962;4715.316279139574;5355.919661205163;5817.883642327214;6071.028635418312;6101.176341193882;6234.501239900887;6240.28236752761;6245.219347581552;6248.250209974832;6265.592736472115;5207.3490813648295;5846.766129354778;6044.304904935989;6131.509479241739;6142.836439233887 14:54:08 INFO - PROCESS | 1663 | |5;yui.html;630.842289427643;645.3449748505271;653.3499168327514;664.1930054983194;677.7729460630688;14783.11729212804;15251.618709532268;15254.38982440701;15295.005824621405;15311.923440382783;13549.93225033876;14666.19335936523;14704;14706.117632942005;14707;900.6667533012794;907.9863802042975;917.3761841947473;917.5228880981919;920.9677661281856;711.8718630646482;733.3912852332578;889.5685592487638;922.2391526990226;922.4142669404943;960.9759756006085;965.3483898368609;968.2302569457263;968.801395713877;970.3062310448029;738.65283316841;959.2661613865398;963.5086106085877;964.3297907953975;964.3635200767495;685.7565564224728;706.8515611721544;707.6497133918743;708.2457183100033;708.9326513981215;15185.848141518554;15206.467773627981;15222.543323700196;15242.314095865713;15251.923740381339;12274;12338.629841104781;12483.563075292412;12581.155111902168;12738.426770795337;8065.596720163969;9821;9936.90063099367;9962.551685174185;10183.694489165337;3437.9656203438144;3500.912477188065;3587.3004764071015;3590.120420496995;3622.8188590570367;74683.62658186728;75184.87222691665;77176;77680;77731.61134194293;9354.95322523383;9391.295652826066;9518.095780900803;9666.661666841626;9992.350497217658;21623.783762162493;21652.35042948714;21675.891620541795;21711.240106596193;21713.782862171178;6593.3736295051895;7401.962990185015;7434.628268586549;7623.35201507867;7665.731699390494;3979.3235150024566;4094.3858421236455;4106.7946602669745;4117.114820313647;4132.524759652619;3397.473391624302;3490.511328414024;3510.526078979356;3511.631278715749;3516.7186625070444;606.9362716914749;616.5468380740152;618.153130211613;626.9780557680459;641.7304732012566;500.669558091665;551.6469459545893;560.95512359012;571.9428057194248;600.072887388985;7522.623868806538;7942;8093.919060809434;8138.43030987837;8349.791255218546;482.35605466702344;556.9751656951229;557.8577462746973;605.4974371271834;615.566025951703;3800.562935262425;3808.352580061396;3823.7323387362617;3853.679666611896;3950.111224974415;90888;90964;94645.053549465;95558.52220738852;96311.0368896316;65644.37422503046;67350;71536.64231678912;71640.28359716441;77027;67403.65192696119;67728.85660435876;67898.66050669814;70070.64964675246;70304.64847675627;7404.555726656418;7453.180150183584;7624.390048795972;7699.615019249127;7881.684732610861;37242;38563;41476.79261603673;41542;42111.7894410526;58649.413505864395;58825.411745882;62005.68997154985;63649.6817515928;63720.68139659272;10080.54637541327;10231.641892533726;10295.88934268488;10352.53413596375;10382.844257336297;10946.39794811293;11113.83329250078;11113.944430278121;11491.023263022737;11519.481623327138;10399.32404393712;10470.319429237075;10576.139052960209;10773.030427261585;10834.783304334027;10366.5335059924;10437;10607;11008.284461509977;11518.136139789382;10194.133498652402;10246.846297305696;10380.584776608852;10637.255392122786;10732.678019659423;8771.342149338952;8858.15847494487;9017.458952462874;9104.317176211678;9197.080291971017;8625.611847466753;8801.295896328407;8848.336374771789;8962.551872406224;9010.459372437412 14:54:08 INFO - PROCESS | 1663 | __end_tp_report 14:54:08 INFO - PROCESS | 1663 | __start_cc_report 14:54:08 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1222 14:54:08 INFO - PROCESS | 1663 | __end_cc_report 14:54:08 INFO - PROCESS | 1663 | __startTimestamp1460238848689__endTimestamp 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | ------- Summary: start ------- 14:54:08 INFO - PROCESS | 1663 | Number of tests: 6 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5672.68 Median:5895.32 stddev:664.71 (11.3%) stddev-sans-first:641.52 14:54:08 INFO - PROCESS | 1663 | Values: 3360.3 3411.6 3447.6 3453.2 3483.8 5565.1 5660.6 5664.2 5670.4 5705.4 5675.8 5703.8 5843.4 5896.5 5913.5 5098.8 5129.7 5162.5 5173.9 5295.0 4342.5 5261.6 5298.7 5325.9 5360.8 5082.9 5130.1 5189.5 5190.2 5251.5 5012.4 5026.2 5030.0 5098.1 5106.4 4935.4 5023.1 5037.0 5037.8 5041.5 5406.8 5448.0 5495.3 5603.8 5632.3 6198.3 6213.0 6229.1 6236.1 6246.8 6219.1 6268.2 6272.0 6292.2 6309.8 5597.5 5713.2 5713.6 5752.7 5757.0 6115.6 6173.6 6218.8 6263.4 6265.9 5083.5 5347.2 6044.1 6099.3 6107.2 5422.4 6198.8 6240.4 6244.0 6247.9 6096.8 6125.5 6164.3 6173.1 6228.2 6214.8 6219.3 6239.0 6248.1 6256.5 4167.9 4885.3 4885.6 4926.0 4926.1 3900.0 3960.3 4314.2 4356.9 4448.4 5617.0 5658.2 5667.7 5669.4 5679.9 6249.2 6267.5 6293.8 6308.3 6309.3 5659.9 5688.2 5690.5 5703.6 5731.9 5269.7 5298.7 5344.1 5383.1 5402.4 5335.8 6248.6 6288.7 6312.2 6318.7 6223.6 6248.3 6261.7 6266.2 6286.2 5467.6 6220.3 6247.8 6263.9 6321.1 6147.1 6148.0 6151.1 6167.8 6167.9 6032.4 6219.3 6246.7 6247.7 6266.9 5786.2 5945.3 6064.2 6069.3 6103.4 5977.8 5994.9 5997.5 6008.2 6035.0 5772.3 5879.9 5895.3 5898.2 5908.5 6031.1 6083.7 6106.3 6120.6 6120.8 5846.5 5922.3 5937.6 5970.6 6008.1 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:61246.06 Median:35943.28 stddev:129956.52 (361.6%) stddev-sans-first:130241.04 14:54:08 INFO - PROCESS | 1663 | Values: 499.6 501.2 514.6 527.7 531.4 29349.6 37676.1 37750.4 37758.0 37814.6 39951.0 40524.0 40562.0 40571.0 40698.8 9239.6 9489.5 9489.8 9494.0 9504.8 9315.9 9490.0 9490.7 9573.5 9595.2 9504.9 9607.6 9617.7 9630.4 9651.1 9536.8 9612.3 9612.4 9612.6 9613.9 9458.1 9484.2 9568.0 9590.1 9597.0 38947.6 39299.0 39343.0 39362.2 39412.2 3203.2 3325.7 3359.9 3367.0 3410.5 27939.9 28234.0 28463.4 28521.3 28530.4 2678.3 2733.9 2768.4 2838.2 2912.0 465230.3 465615.4 466900.0 466945.0 467696.0 57595.0 57821.4 58106.5 58335.5 58508.4 61493.7 64905.0 66716.0 66802.3 66993.7 16025.8 16253.9 16268.4 16274.8 16307.4 12467.3 12517.0 12523.7 12526.8 12538.6 18710.9 18723.9 18742.0 18752.8 19207.3 7123.7 7172.9 7488.6 7504.0 7994.7 869.5 894.2 936.7 945.0 1158.4 28397.0 28916.3 29023.9 29298.6 29641.7 1039.1 1055.1 1084.3 1103.5 1106.7 14667.6 14780.7 14898.3 15175.6 15195.3 604025.0 604196.0 612029.0 612063.0 613253.0 57800.4 58570.0 58653.0 58785.1 58844.4 1292.2 1414.4 1415.6 1461.7 1473.0 27805.6 27809.6 28326.4 28570.9 28620.4 44578.3 45168.8 45181.9 45251.8 45277.8 339762.0 350616.0 351200.0 351773.0 353189.0 22679.0 25376.5 25568.0 25848.6 26158.6 40278.0 40373.8 40506.0 40959.8 41478.4 33851.8 34281.0 34409.3 34868.3 35333.8 34958.3 35085.5 35659.0 35701.3 35769.3 35118.9 35220.8 35320.8 35784.5 36102.1 23996.6 30295.7 30427.5 30454.9 30500.1 22812.4 23159.4 23287.5 23452.9 23567.9 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34413.71 Median:26464.60 stddev:101991.84 (385.4%) stddev-sans-first:102245.95 14:54:08 INFO - PROCESS | 1663 | Values: 383.4 385.6 385.9 399.3 405.7 19290.1 20424.4 20436.2 20445.6 20748.2 12000.9 12102.3 12181.2 12344.8 12375.9 5289.8 5450.1 5497.9 5499.0 5510.8 3886.1 4151.1 5832.7 6158.4 6164.9 6047.3 6143.9 6145.5 6150.4 6160.6 4839.4 5933.3 6016.8 6027.7 6029.5 3753.3 5592.8 5999.3 5999.8 6017.8 13729.4 13845.9 17801.9 26443.2 26486.0 1983.7 2047.3 2106.0 2189.3 2723.9 9583.6 10177.4 10204.8 10394.4 10455.9 1757.2 1765.3 1782.1 1784.7 1787.1 122993.0 127167.4 127718.0 127919.0 129374.0 10820.1 11674.8 11707.4 11863.6 11896.5 15364.0 15478.0 15478.5 15521.9 15547.6 8425.7 8602.3 8607.9 8703.6 8743.9 6409.8 8166.2 8389.7 8393.2 8503.0 3889.8 4610.5 4642.4 4679.4 4687.9 1769.6 1830.1 1833.1 1976.2 1990.8 887.5 916.9 964.0 1031.7 1074.3 19360.1 19628.4 19907.6 20208.3 20255.2 930.6 942.1 965.2 1005.5 1012.5 7844.5 9135.5 10401.4 10570.9 10639.4 524880.0 620037.0 630286.0 634523.0 643132.5 71509.6 74702.9 108638.0 132172.3 138283.3 1029.9 1035.5 1057.3 1077.4 1085.2 17453.0 17726.4 17730.7 17787.1 18136.5 51534.5 51893.5 52957.0 53653.7 53804.7 77603.6 78492.6 79206.2 79381.0 82467.0 7942.4 8027.1 8066.0 8201.6 8261.2 8512.7 9064.5 10414.6 11250.9 12438.6 5004.1 9355.5 10768.0 10838.7 11086.3 10257.3 10655.4 10843.2 10938.6 11094.4 9900.4 10586.6 11449.7 11553.0 11606.9 8071.0 8256.3 8280.2 8381.7 8427.9 9929.5 11009.3 11263.2 11352.7 11384.5 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6010.48 Median:5360.44 stddev:3169.67 (59.1%) stddev-sans-first:3159.52 14:54:08 INFO - PROCESS | 1663 | Values: 1388.9 1580.1 1582.8 1836.1 1985.2 7875.3 8653.7 8869.1 8877.3 8893.3 8477.8 8727.7 8731.1 8734.4 8734.6 2156.8 2462.2 2499.2 2500.2 2507.1 2501.9 2526.5 2529.2 2531.2 2532.8 2347.7 2350.4 2350.9 2352.4 2416.6 2460.4 2473.0 2480.6 2482.5 2482.9 2448.0 2461.2 2471.2 2481.0 2485.0 8567.9 8733.2 8736.4 8737.8 8741.1 5171.6 5362.6 5366.1 5376.1 5404.7 3485.1 3501.1 3513.1 3548.4 3559.1 1000.4 1004.5 1009.0 1016.2 1025.0 11452.1 11455.8 11458.8 11470.5 11489.5 4682.5 4762.4 4818.4 4893.0 4910.1 9782.9 9809.7 9825.5 9834.5 9840.2 5350.4 5358.3 5362.7 5401.2 5405.9 4342.5 4505.5 4709.6 4824.8 4825.5 3949.5 3980.2 4046.0 4118.3 4119.6 1319.1 1330.4 1331.1 1343.1 1347.2 1329.9 1332.9 1358.8 1362.9 1396.2 7943.4 8080.6 8127.3 8145.6 8158.4 501.4 512.7 516.8 517.7 522.5 6211.9 6249.5 6336.6 6361.8 6367.7 10231.2 10569.7 10573.4 10675.8 10726.0 9965.9 10553.3 10560.3 10560.9 10630.8 7936.6 8005.6 8047.9 8089.5 8121.8 8006.0 8168.4 8208.2 8246.3 8249.7 9479.4 9517.4 9671.0 9695.4 9893.3 9818.4 10019.7 10111.4 10175.8 10273.6 6427.4 6791.4 7366.6 7527.7 7672.0 8246.7 8252.8 8331.5 8341.1 8362.8 6987.7 7302.7 7305.8 7391.5 7502.1 6975.1 7200.5 7218.1 7292.1 7300.9 7698.6 7704.0 7720.2 7735.0 7738.4 6934.5 6940.4 7029.3 7046.3 7064.2 7059.9 7157.0 7173.0 7182.7 7234.6 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4983.89 Median:5645.55 stddev:1537.15 (27.2%) stddev-sans-first:1500.93 14:54:08 INFO - PROCESS | 1663 | Values: 311.6 315.1 323.0 324.4 326.0 4977.8 5361.5 5907.1 5954.7 5999.3 5501.2 5877.4 5883.0 5914.5 5915.7 4037.9 4169.9 4314.4 4419.2 4432.2 4421.5 4446.8 4474.6 4482.8 4487.5 4436.2 4452.6 4454.5 4482.6 4495.1 3924.0 4190.3 4204.4 4466.1 4477.8 3802.1 3804.9 3816.7 3816.9 3840.7 5631.7 5640.2 5644.7 5668.1 5669.7 4526.7 4887.7 5060.5 5088.4 5162.7 5504.8 5868.6 6191.3 6192.8 6197.4 4191.7 4209.7 4217.3 4222.8 4231.0 5060.2 5115.5 6286.9 6307.1 6538.1 3666.7 3931.7 4040.6 4293.2 4294.9 4189.5 4362.5 4380.4 4388.2 4389.9 3877.9 4451.1 5074.2 5075.4 5097.6 6137.2 6210.3 6212.3 6231.3 6242.9 1369.5 1429.9 1459.2 1461.5 1463.2 804.1 934.2 948.7 954.0 960.0 4954.6 5763.3 5788.3 5792.2 5808.2 5635.7 5669.4 6427.5 6435.9 6449.4 5575.2 5747.8 5812.9 5825.6 5863.9 2979.8 3371.0 3377.4 3389.2 3398.8 5308.4 5642.6 5652.9 6661.0 6678.9 6015.7 6133.3 6328.7 6575.4 6580.2 5356.9 5801.3 5813.3 6369.5 6671.2 6052.3 6372.9 6391.7 6396.4 6419.6 5192.5 5735.7 6065.7 6313.9 6318.1 6340.0 6506.8 6572.9 6628.9 6787.4 4188.8 4198.8 4199.6 4201.8 4207.2 5428.4 5646.4 6151.1 6434.8 6506.4 6199.4 6207.3 6216.9 6221.4 6239.7 5222.0 5742.3 6162.3 6205.3 6209.8 4715.3 5355.9 5817.9 6071.0 6101.2 6234.5 6240.3 6245.2 6248.3 6265.6 5207.3 5846.8 6044.3 6131.5 6142.8 14:54:08 INFO - PROCESS | 1663 | 14:54:08 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:17363.76 Median:31311.92 stddev:24415.91 (78.0%) stddev-sans-first:24452.08 14:54:08 INFO - PROCESS | 1663 | Values: 630.8 645.3 653.3 664.2 677.8 14783.1 15251.6 15254.4 15295.0 15311.9 13549.9 14666.2 14704.0 14706.1 14707.0 900.7 908.0 917.4 917.5 921.0 711.9 733.4 889.6 922.2 922.4 961.0 965.3 968.2 968.8 970.3 738.7 959.3 963.5 964.3 964.4 685.8 706.9 707.6 708.2 708.9 15185.8 15206.5 15222.5 15242.3 15251.9 12274.0 12338.6 12483.6 12581.2 12738.4 8065.6 9821.0 9936.9 9962.6 10183.7 3438.0 3500.9 3587.3 3590.1 3622.8 74683.6 75184.9 77176.0 77680.0 77731.6 9355.0 9391.3 9518.1 9666.7 9992.4 21623.8 21652.4 21675.9 21711.2 21713.8 6593.4 7402.0 7434.6 7623.4 7665.7 3979.3 4094.4 4106.8 4117.1 4132.5 3397.5 3490.5 3510.5 3511.6 3516.7 606.9 616.5 618.2 627.0 641.7 500.7 551.6 561.0 571.9 600.1 7522.6 7942.0 8093.9 8138.4 8349.8 482.4 557.0 557.9 605.5 615.6 3800.6 3808.4 3823.7 3853.7 3950.1 90888.0 90964.0 94645.1 95558.5 96311.0 65644.4 67350.0 71536.6 71640.3 77027.0 67403.7 67728.9 67898.7 70070.6 70304.6 7404.6 7453.2 7624.4 7699.6 7881.7 37242.0 38563.0 41476.8 41542.0 42111.8 58649.4 58825.4 62005.7 63649.7 63720.7 10080.5 10231.6 10295.9 10352.5 10382.8 10946.4 11113.8 11113.9 11491.0 11519.5 10399.3 10470.3 10576.1 10773.0 10834.8 10366.5 10437.0 10607.0 11008.3 11518.1 10194.1 10246.8 10380.6 10637.3 10732.7 8771.3 8858.2 9017.5 9104.3 9197.1 8625.6 8801.3 8848.3 8962.6 9010.5 14:54:08 INFO - PROCESS | 1663 | -------- Summary: end -------- 14:54:08 INFO - PROCESS | 1663 | 14:54:09 INFO - TEST-INFO | 1663: exit 0 14:54:09 INFO - TEST-OK | dromaeo_css | took 1114095ms 14:54:09 INFO - TEST-START | kraken 14:54:09 INFO - operating with platform_type : mac_ 14:54:09 INFO - Initialising browser for kraken test... 14:54:09 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp4QIcAC/profile http://localhost:49270/getInfo.html) 14:54:11 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 14:54:11 INFO - PROCESS | 1672 | colorDepth:24 14:54:11 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 14:54:11 INFO - PROCESS | 1672 | __metrics 14:54:11 INFO - PROCESS | 1672 | 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" 14:54:11 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:54:12 INFO - TEST-INFO | 1672: exit 0 14:54:12 INFO - Browser initialized. 14:54:12 INFO - Running cycle 1/1 for kraken test... 14:54:12 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp4QIcAC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:24 INFO - PROCESS | 1674 | RSS: Main: 237498368 14:54:24 INFO - PROCESS | 1674 | 14:54:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:27 INFO - PROCESS | 1674 | RSS: Main: 283705344 14:54:27 INFO - PROCESS | 1674 | 14:54:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:54:30 INFO - PROCESS | 1674 | RSS: Main: 294199296 14:54:30 INFO - PROCESS | 1674 | 14:54:34 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:54:34 INFO - PROCESS | 1674 | RSS: Main: 281219072 14:54:34 INFO - PROCESS | 1674 | 14:54:36 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:54:37 INFO - PROCESS | 1674 | RSS: Main: 283951104 14:54:37 INFO - PROCESS | 1674 | 14:54:39 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:40 INFO - PROCESS | 1674 | RSS: Main: 284176384 14:54:40 INFO - PROCESS | 1674 | 14:54:42 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:54:43 INFO - PROCESS | 1674 | RSS: Main: 284352512 14:54:43 INFO - PROCESS | 1674 | 14:54:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:54:46 INFO - PROCESS | 1674 | RSS: Main: 284577792 14:54:46 INFO - PROCESS | 1674 | 14:54:49 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:54:50 INFO - PROCESS | 1674 | RSS: Main: 285462528 14:54:50 INFO - PROCESS | 1674 | 14:54:51 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:54:52 INFO - PROCESS | 1674 | RSS: Main: 318345216 14:54:52 INFO - PROCESS | 1674 | 14:54:54 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:54:54 INFO - PROCESS | 1674 | RSS: Main: 317100032 14:54:54 INFO - PROCESS | 1674 | 14:54:57 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:54:57 INFO - PROCESS | 1674 | RSS: Main: 324022272 14:54:57 INFO - PROCESS | 1674 | 14:55:00 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:01 INFO - PROCESS | 1674 | RSS: Main: 325357568 14:55:01 INFO - PROCESS | 1674 | 14:55:04 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:04 INFO - PROCESS | 1674 | RSS: Main: 325316608 14:55:04 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:55:06 INFO - PROCESS | 1674 | RSS: Main: 389517312 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | __start_tp_report 14:55:06 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 14:55:06 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 14:55:06 INFO - PROCESS | 1674 | |i|pagename|runs| 14:55:06 INFO - PROCESS | 1674 | |0;ai-astar;113;110;113;113;114;114;119;113;112;113 14:55:06 INFO - PROCESS | 1674 | |1;audio-beat-detection;156;123;143;175;153;172;153;120;168;145 14:55:06 INFO - PROCESS | 1674 | |2;audio-dft;185;186;185;187;184;185;182;204;172;260 14:55:06 INFO - PROCESS | 1674 | |3;audio-fft;72;79;83;79;56;58;58;75;78;56 14:55:06 INFO - PROCESS | 1674 | |4;audio-oscillator;90;90;131;78;96;108;155;109;76;120 14:55:06 INFO - PROCESS | 1674 | |5;imaging-gaussian-blur;91;88;91;88;91;88;91;88;91;87 14:55:06 INFO - PROCESS | 1674 | |6;imaging-darkroom;96;96;96;100;96;95;96;96;97;96 14:55:06 INFO - PROCESS | 1674 | |7;imaging-desaturate;87;89;88;86;84;87;84;85;86;85 14:55:06 INFO - PROCESS | 1674 | |8;json-parse-financial;54;56;54;53;54;54;56;66;55;52 14:55:06 INFO - PROCESS | 1674 | |9;json-stringify-tinderbox;63;63;74;73;70;68;68;68;65;92 14:55:06 INFO - PROCESS | 1674 | |10;stanford-crypto-aes;86;87;85;86;85;87;83;95;111;109 14:55:06 INFO - PROCESS | 1674 | |11;stanford-crypto-ccm;145;145;141;142;148;154;140;144;143;146 14:55:06 INFO - PROCESS | 1674 | |12;stanford-crypto-pbkdf2;170;182;175;170;169;173;172;171;169;170 14:55:06 INFO - PROCESS | 1674 | |13;stanford-crypto-sha256-iterative;69;70;87;96;93;94;69;69;67;66 14:55:06 INFO - PROCESS | 1674 | __end_tp_report 14:55:06 INFO - PROCESS | 1674 | __start_cc_report 14:55:06 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1330 14:55:06 INFO - PROCESS | 1674 | __end_cc_report 14:55:06 INFO - PROCESS | 1674 | __startTimestamp1460238906763__endTimestamp 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | ------- Summary: start ------- 14:55:06 INFO - PROCESS | 1674 | Number of tests: 14 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.00 stddev:2.27 (2.0%) stddev-sans-first:2.40 14:55:06 INFO - PROCESS | 1674 | Values: 113.0 110.0 113.0 113.0 114.0 114.0 119.0 113.0 112.0 113.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.50 stddev:18.81 (12.2%) stddev-sans-first:19.85 14:55:06 INFO - PROCESS | 1674 | Values: 156.0 123.0 143.0 175.0 153.0 172.0 153.0 120.0 168.0 145.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#2] audio-dft Cycles:10 Average:193.00 Median:185.50 stddev:24.79 (13.4%) stddev-sans-first:26.12 14:55:06 INFO - PROCESS | 1674 | Values: 185.0 186.0 185.0 187.0 184.0 185.0 182.0 204.0 172.0 260.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#3] audio-fft Cycles:10 Average:69.40 Median:76.50 stddev:11.06 (14.5%) stddev-sans-first:11.69 14:55:06 INFO - PROCESS | 1674 | Values: 72.0 79.0 83.0 79.0 56.0 58.0 58.0 75.0 78.0 56.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#4] audio-oscillator Cycles:10 Average:105.30 Median:77.00 stddev:24.78 (32.2%) stddev-sans-first:25.66 14:55:06 INFO - PROCESS | 1674 | Values: 90.0 90.0 131.0 78.0 96.0 108.0 155.0 109.0 76.0 120.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:91.00 stddev:1.71 (1.9%) stddev-sans-first:1.72 14:55:06 INFO - PROCESS | 1674 | Values: 91.0 88.0 91.0 88.0 91.0 88.0 91.0 88.0 91.0 87.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 14:55:06 INFO - PROCESS | 1674 | Values: 96.0 96.0 96.0 100.0 96.0 95.0 96.0 96.0 97.0 96.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.50 stddev:1.66 (1.9%) stddev-sans-first:1.73 14:55:06 INFO - PROCESS | 1674 | Values: 87.0 89.0 88.0 86.0 84.0 87.0 84.0 85.0 86.0 85.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.92 (7.2%) stddev-sans-first:4.13 14:55:06 INFO - PROCESS | 1674 | Values: 54.0 56.0 54.0 53.0 54.0 54.0 56.0 66.0 55.0 52.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:69.00 stddev:8.45 (12.2%) stddev-sans-first:8.53 14:55:06 INFO - PROCESS | 1674 | Values: 63.0 63.0 74.0 73.0 70.0 68.0 68.0 68.0 65.0 92.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:86.00 stddev:10.31 (12.0%) stddev-sans-first:10.75 14:55:06 INFO - PROCESS | 1674 | Values: 86.0 87.0 85.0 86.0 85.0 87.0 83.0 95.0 111.0 109.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:145.00 stddev:4.02 (2.8%) stddev-sans-first:4.27 14:55:06 INFO - PROCESS | 1674 | Values: 145.0 145.0 141.0 142.0 148.0 154.0 140.0 144.0 143.0 146.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:171.50 stddev:3.96 (2.3%) stddev-sans-first:4.12 14:55:06 INFO - PROCESS | 1674 | Values: 170.0 182.0 175.0 170.0 169.0 173.0 172.0 171.0 169.0 170.0 14:55:06 INFO - PROCESS | 1674 | 14:55:06 INFO - PROCESS | 1674 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:78.50 stddev:12.73 (16.2%) stddev-sans-first:13.08 14:55:06 INFO - PROCESS | 1674 | Values: 69.0 70.0 87.0 96.0 93.0 94.0 69.0 69.0 67.0 66.0 14:55:06 INFO - PROCESS | 1674 | -------- Summary: end -------- 14:55:06 INFO - PROCESS | 1674 | 14:55:07 INFO - TEST-INFO | 1674: exit 0 14:55:07 INFO - TEST-OK | kraken | took 58264ms 14:55:07 INFO - SUITE-END | took 1172s 14:55:07 INFO - Completed test suite (00:19:32) 14:55:07 INFO - javascript benchmark 14:55:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.3279344131174, 3411.62472128066, 3447.620761716209, 3453.223024819416, 3483.8432270547823, 5565.109582466806, 5660.575456840733, 5664.178694089354, 5670.432956704328, 5705.372409035008, 5675.801346952858, 5703.800366987156, 5843.4156584341545, 5896.5282777377815, 5913.497352725013, 5098.847034588968, 5129.6665716728385, 5162.457941916101, 5173.948260517384, 5294.973525132388, 4342.522322544518, 5261.605379596526, 5298.708571028592, 5325.946740532584, 5360.758765855546, 5082.949170508285, 5130.050940576006, 5189.532942035235, 5190.221466779975, 5251.501107394792, 5012.398512178525, 5026.246063090565, 5029.974850125763, 5098.056859480971, 5106.412762532282, 4935.407751069894, 5023.14606516893, 5037.0429618372755, 5037.773300201463, 5041.495850414965, 5406.783728650849, 5448.0, 5495.258140151069, 5603.831885043455, 5632.295963004624, 6198.349173336825, 6213.03697926822, 6229.127922090911, 6236.126942228047, 6246.781362652331, 6219.09823075656, 6268.15379923709, 6272.027835685476, 6292.244930608311, 6309.779157729457, 5597.496225339698, 5713.200151978726, 5713.600047996601, 5752.741126649311, 5756.971215143939, 6115.6330620162935, 6173.629582225081, 6218.782342618078, 6263.4362907338555, 6265.874682506415, 5083.491650834887, 5347.171188465794, 6044.123602077762, 6099.2985806632805, 6107.175531303306, 5422.40353561108, 6198.81403557894, 6240.438360547572, 6243.96878015607, 6247.9062814057825, 6096.817095487142, 6125.509959203253, 6164.260288765377, 6173.135760993465, 6228.159198508234, 6214.751409943552, 6219.315875253718, 6238.968805156036, 6248.062790581449, 6256.499480041586, 4167.854125105607, 4885.316055752198, 4885.560299573055, 4926.014797040606, 4926.113299606033, 3899.9610003900166, 3960.346542820402, 4314.245007123741, 4356.9128617428105, 4448.399466072104, 5616.971915140398, 5658.151277308437, 5667.688277144714, 5669.40471250521, 5679.943200568024, 6249.156363890907, 6267.4986001119805, 6293.811185664437, 6308.3060863305, 6309.274433440213, 5659.943400566024, 5688.23208866806, 5690.5447564194765, 5703.600747947604, 5731.914021289684, 5269.736513174326, 5298.708571028554, 5344.091504444254, 5383.111786555174, 5402.405735369106, 5335.759890804923, 6248.625082495065, 6288.748450061947, 6312.242530896322, 6318.71565779541, 6223.621359126879, 6248.281447633581, 6261.65560894137, 6266.248050234001, 6286.15136956505, 5467.617266791445, 6220.284667263322, 6247.750089996531, 6263.906041409291, 6321.11504389395, 6147.108669243024, 6148.047052706837, 6151.108089327112, 6167.753289868535, 6167.907481387872, 6032.366601506778, 6219.284782250099, 6246.718897649525, 6247.656378899204, 6266.874662506815, 5786.218860453953, 5945.34601193877, 6064.211652485149, 6069.2716873975405, 6103.389661033861, 5977.790777322773, 5994.850128746816, 5997.460228579449, 6008.1588577598295, 6034.969825150846, 5772.307323121252, 5879.853003674943, 5895.322037965689, 5898.233229680286, 5908.497777688945, 6031.125486804476, 6083.695815209133, 6106.297775755845, 6120.571559990936, 6120.816375508742, 5846.473817356458, 5922.318933322723, 5937.643741375531, 5970.58205925581, 6008.068749343859], "value": 5630.172624706164, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.6078078708215, 501.2206019639459, 514.6448950224345, 527.7229454536368, 531.449949302472, 29349.55975660364, 37676.05809854752, 37750.43374349387, 37758.0, 37814.62185378146, 39951.00122496932, 40523.98690032751, 40562.0, 40571.0, 40698.79650601743, 9239.6304147834, 9489.478078705668, 9489.81020379592, 9494.0, 9504.809903801919, 9315.860262096074, 9489.952550237274, 9490.71527854162, 9573.473458959754, 9595.23238140947, 9504.904950950506, 9607.615695372211, 9617.663381781638, 9630.422174669542, 9651.131398174162, 9536.809263814719, 9612.327137100407, 9612.423254604746, 9612.567434465465, 9613.855792163053, 9458.054194580556, 9484.19384352331, 9568.043195680446, 9590.08894155054, 9596.95201523988, 38947.61052389497, 39299.0, 39343.016424589325, 39362.21275574501, 39412.21175576472, 3203.2472368993267, 3325.6840600142946, 3359.9160020999425, 3366.9831650841834, 3410.454327307644, 27939.860300698365, 28234.011809586566, 28463.430731385462, 28521.286967825763, 28530.429391412265, 2678.34380576758, 2733.9179824605294, 2768.418632087244, 2838.205302515278, 2911.980806717653, 465230.34769652545, 465615.42268907186, 466900.0, 466945.0, 467696.0, 57595.0, 57821.42178578245, 58106.54733631693, 58335.5416114592, 58508.41491585115, 61493.69253153705, 64905.0, 66716.0, 66802.33197668058, 66993.66503167551, 16025.839741602435, 16253.918730406509, 16268.430604928772, 16274.75587866183, 16307.429239976782, 12467.314297713712, 12517.0, 12523.686907827378, 12526.81209781854, 12538.561150359694, 18710.8773473592, 18723.90638046801, 18742.0, 18752.781069230456, 19207.32774352891, 7123.679434425463, 7172.928270717226, 7488.588127652923, 7503.962480187564, 7994.68021279154, 869.5217630303308, 894.2220268366563, 936.7330310861508, 944.9527523623791, 1158.3860553906443, 28397.0, 28916.277093072422, 29023.896637323636, 29298.560521592193, 29641.703582964325, 1039.1219419590434, 1055.1137044882182, 1084.3168803653805, 1103.4813637590319, 1106.6624679472677, 14667.633309167357, 14780.704385912222, 14898.329575169144, 15175.571908494589, 15195.316210770541, 604025.0, 604196.0, 612029.0, 612063.0, 613253.0, 57800.42199577951, 58570.0, 58653.0, 58785.11822322669, 58844.41155588475, 1292.2246652008907, 1414.420087764012, 1415.610707055568, 1461.7149655817013, 1472.955811325662, 27805.582916256677, 27809.58285625677, 28326.433471330045, 28570.85716571397, 28620.42759144847, 44578.3313250295, 45168.77415612901, 45181.870453237614, 45251.77374113108, 45277.773611131735, 339762.0, 350616.0, 351200.0, 351773.0, 353189.0, 22679.0, 25376.492470150126, 25567.977280908555, 25848.612270816328, 26158.607620886083, 40277.99305017398, 40373.798131009156, 40506.0, 40959.79520102381, 41478.37782433326, 33851.83074084712, 34280.971570851914, 34409.31181376308, 34868.302633946674, 35333.76331828374, 34958.30083398369, 35085.47371789374, 35659.0, 35701.28597427985, 35769.28461430809, 35118.946431607095, 35220.823895880356, 35320.82339588286, 35784.46323305101, 36102.09744756297, 23996.64005039891, 30295.697043029286, 30427.54358684666, 30454.93407730719, 30500.08499745011, 22812.42968925724, 23159.421014474774, 23287.53424931458, 23452.882735586212, 23567.882160589088], "value": 18925.577456197367, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.39423710537346, 385.610533361305, 385.85337571722744, 399.3490610305202, 405.67140616100977, 19290.131944062516, 20424.387268381935, 20436.182552697894, 20445.591088178247, 20748.170073197052, 12000.859918307748, 12102.334371609559, 12181.20822146562, 12344.753104937918, 12375.876241237585, 5289.841304760854, 5450.100733379008, 5497.890042199154, 5498.972505137469, 5510.8071217507395, 3886.145048089416, 4151.14901445203, 5832.679202643874, 6158.353372895848, 6164.876702465948, 6047.304559975615, 6143.907841382361, 6145.477634401082, 6150.354212807658, 6160.5687601867885, 4839.419269687624, 5933.317668468138, 6016.819495415145, 6027.698615069229, 6029.457348838604, 3753.2681127180213, 5592.7762889484775, 5999.340072592011, 5999.820005399845, 6017.7592896284095, 13729.382177802023, 13845.861541384558, 17801.910990445096, 26443.206703798918, 26486.0, 1983.6826107822824, 2047.2936836791282, 2106.0417510033053, 2189.3322536626324, 2723.8695941184383, 9583.616655333848, 10177.440240786755, 10204.795904081877, 10394.376337419779, 10455.94772026135, 1757.200473784425, 1765.3431585463923, 1782.073321872632, 1784.687679656068, 1787.1332403784154, 122993.0, 127167.36416317952, 127718.0, 127919.0, 129374.0, 10820.13438924884, 11674.824877626843, 11707.414629268673, 11863.644090677293, 11896.464659090361, 15364.0, 15478.0, 15478.5356439307, 15521.922390387976, 15547.611309717122, 8425.668532946911, 8602.268807151462, 8607.870881936777, 8703.606508210292, 8743.907011623547, 6409.775657851953, 8166.1833816619055, 8389.664413423394, 8393.160683931557, 8503.0, 3889.813606849881, 4610.515895830957, 4642.3500709900645, 4679.391679081766, 4687.929681054787, 1769.646070785848, 1830.1355692815735, 1833.0930960783392, 1976.160131943947, 1990.7710613279369, 887.5163036145316, 916.8991410944791, 964.0407794244771, 1031.6595523477235, 1074.3446497636435, 19360.128794204295, 19628.41114766531, 19907.60184796296, 20208.29270975509, 20255.189792408433, 930.6277489004317, 942.1464726352518, 965.2471072563412, 1005.5374527717186, 1012.4532752313816, 7844.529328240324, 9135.54322283883, 10401.375917444826, 10570.894291057144, 10639.361638301727, 524880.0, 620037.0, 630286.0, 634523.0, 643132.490362835, 71509.64245178844, 74702.8794568082, 108637.96344438718, 132172.33913830368, 138283.30858345644, 1029.897010298964, 1035.5236591168148, 1057.2599180573475, 1077.369738702852, 1085.1644233939821, 17452.95282283067, 17726.379576714753, 17730.73403898968, 17787.145625636866, 18136.546586335448, 51534.48465515447, 51893.481065190375, 52957.0, 53653.7317313411, 53804.65488362822, 77603.61198194198, 78492.60753696195, 79206.20793792218, 79381.0, 82467.0, 7942.375130319392, 8027.067326507122, 8066.014645501029, 8201.58992050407, 8261.17388261169, 8512.70205542803, 9064.546772661472, 10414.59402980588, 11250.887491124984, 12438.564650237198, 5004.149294619996, 9355.48544830041, 10768.0, 10838.729031774268, 11086.279391839827, 10257.33327333721, 10655.360678359324, 10843.240973131806, 10938.56245750161, 11094.389808560607, 9900.356476828983, 10586.629467968893, 11449.656510304705, 11553.0, 11606.88393116058, 8071.031476222891, 8256.25693687547, 8280.171982801672, 8381.664733410595, 8427.915720842713, 9929.453880036668, 11009.2843965142, 11263.155263355446, 11352.716182095513, 11384.544618215179], "value": 9168.521184183175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.8958328125393, 1580.0914474177348, 1582.841715828417, 1836.0911348882305, 1985.1860737097793, 7875.251851074146, 8653.653853845846, 8869.113088691127, 8877.334199935014, 8893.333000025008, 8477.830443391129, 8727.694530691428, 8731.083236260181, 8734.432261902972, 8734.563271836414, 2156.7735387784214, 2462.2367066209486, 2499.1627804685454, 2500.1624455807237, 2507.109975958527, 2501.8874150663264, 2526.4568117854656, 2529.203300960201, 2531.1520640585427, 2532.7720505154534, 2347.730011048734, 2350.4358953851124, 2350.9412264693347, 2352.4354155002848, 2416.565018296706, 2460.4463995601027, 2472.950540989179, 2480.578301688717, 2482.453860150773, 2482.8758562071826, 2448.008556534606, 2461.1878080233478, 2471.221565206954, 2480.962785558218, 2485.0, 8567.914320856775, 8733.170348816851, 8736.432131911406, 8737.825243495094, 8741.082186370466, 5171.637985341028, 5362.597805164628, 5366.087765079907, 5376.11294136467, 5404.702741349224, 3485.128717820545, 3501.142220156078, 3513.0690367052753, 3548.3790336690977, 3559.074640593464, 1000.4147573669412, 1004.4626125023151, 1008.9747756306077, 1016.2327442780727, 1024.9500998003991, 11452.141089418326, 11455.770884582345, 11458.770824583462, 11470.541178352856, 11489.540418383254, 4682.461516925598, 4762.404699412574, 4818.416624271144, 4892.975535122301, 4910.116179087727, 9782.9021709782, 9809.656662016796, 9825.508724563742, 9834.459104749307, 9840.212782977345, 5350.357957045179, 5358.27663265462, 5362.678239305654, 5401.216823560561, 5405.891882162335, 4342.457192850894, 4505.48186958504, 4709.646776491777, 4824.807007719652, 4825.541573550507, 3949.5063117110362, 3980.24375368679, 4046.0289530512464, 4118.258713431611, 4119.608637179464, 1319.1359659423092, 1330.4279159961309, 1331.0749029424458, 1343.06656873472, 1347.158026233604, 1329.9202047877159, 1332.8667133286594, 1358.7893876449166, 1362.9114107582975, 1396.1692792788274, 7943.443958922935, 8080.55556944362, 8127.349812015024, 8145.633446494922, 8158.4289099762445, 501.3732833957553, 512.6898226572944, 516.7752027867889, 517.735954663117, 522.5323335614604, 6211.9068213976825, 6249.531285153632, 6336.556441049082, 6361.840953976188, 6367.681615919186, 10231.181505479544, 10569.735756606146, 10573.365598064142, 10675.83986240207, 10725.981031801966, 9965.850512242323, 10553.314034587727, 10560.260781745204, 10560.894391056145, 10630.840537391945, 7936.563489008045, 8005.599720013976, 8047.919520804717, 8089.514629122272, 8121.75634730959, 8005.9599702001115, 8168.387370947084, 8208.179182081743, 8246.257836794717, 8249.711260105867, 9479.431234125974, 9517.42895426249, 9670.99545601288, 9695.369800962915, 9893.307468477138, 9818.410895346302, 10019.749506262402, 10111.39331640104, 10175.796484070424, 10273.640422585173, 6427.3999320319235, 6791.422729068085, 7366.594837284001, 7527.698892044257, 7672.0409948756405, 8246.711365102192, 8252.793680158044, 8331.541765202972, 8341.12418196105, 8362.832743345221, 6987.650617469005, 7302.671379788028, 7305.780826575211, 7391.519551229153, 7502.062242219723, 6975.128108986377, 7200.459965502503, 7218.133823941161, 7292.088488938883, 7300.853982920418, 7698.576578288248, 7703.998480197539, 7720.150783413932, 7734.961325193338, 7738.41961852852, 6934.514583979275, 6940.375366217065, 7029.26192749754, 7046.330598593126, 7064.187618423742, 7059.929400706133, 7157.033800437082, 7173.0, 7182.676779544829, 7234.5659260444545], "value": 4826.356089724588, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.6384993407646, 315.1035304558531, 322.99192520186995, 324.36748340735573, 325.97968359036213, 4977.825776097838, 5361.51746342829, 5907.105518296036, 5954.672493012882, 5999.280086389639, 5501.174823776436, 5877.383719477146, 5882.970585147068, 5914.467697907187, 5915.722446857958, 4037.899052523696, 4169.937450938223, 4314.389794174526, 4419.182451246522, 4432.20220360335, 4421.4694236691485, 4446.799894004761, 4474.574915383034, 4482.775861206943, 4487.461504619434, 4436.179306828231, 4452.554744525538, 4454.48773391061, 4482.551744825508, 4495.078508905666, 3924.0, 4190.266703326905, 4204.411382406451, 4466.062126953344, 4477.776111194444, 3802.0874990002476, 3804.90487737806, 3816.6755825754844, 3816.923661526782, 3840.6927445804267, 5631.690257035862, 5640.182173584848, 5644.689542075184, 5668.089018577169, 5669.716514174274, 4526.705764125321, 4887.657863949525, 5060.544550990392, 5088.4148322942965, 5162.664426812245, 5504.752286147133, 5868.559858010666, 6191.254291153877, 6192.783252586138, 6197.380261973812, 4191.72753771007, 4209.7474151551005, 4217.283061879488, 4222.788860556991, 4231.0, 5060.2156665716875, 5115.488451154892, 6286.868363694533, 6307.148534947769, 6538.117354157175, 3666.7433279670167, 3931.66580840626, 4040.6363427291685, 4293.2057569349145, 4294.935575966363, 4189.476315460567, 4362.476502819619, 4380.408644832971, 4388.166248412791, 4389.868303950887, 3877.922441551153, 4451.109778044404, 5074.23886417033, 5075.365579302587, 5097.566706829961, 6137.202163718688, 6210.347913469111, 6212.285587157535, 6231.345708700612, 6242.875142497124, 1369.4795977528474, 1429.9499517517045, 1459.2120255062148, 1461.5396150212862, 1463.2464280895347, 804.1476035402492, 934.2385955446425, 948.7059011706393, 953.9570719317647, 959.9616015359308, 4954.578860796801, 5763.279590051244, 5788.27646544182, 5792.189093526909, 5808.215890854681, 5635.67495177847, 5669.399931043817, 6427.453666438311, 6435.903461448082, 6449.419552240321, 5575.1915972184615, 5747.770089196385, 5812.895549845516, 5825.563082768809, 5863.944489991757, 2979.8361090139815, 3370.97185358468, 3377.382528540352, 3389.18659521713, 3398.805123184199, 5308.442613525602, 5642.6332288401945, 5652.925944070614, 6660.966695166493, 6678.866422671616, 6015.729292181863, 6133.264008318941, 6328.746850125944, 6575.44108750752, 6580.243272023778, 5356.919646205232, 5801.3038435388025, 5813.302403711582, 6369.522285828489, 6671.232808227019, 6052.303985041776, 6372.921330348673, 6391.680415979089, 6396.392342727433, 6419.614823110628, 5192.480751924928, 5735.655860648374, 6065.72704228302, 6313.873722525615, 6318.147050148171, 6339.9683001586545, 6506.804795856132, 6572.934270657232, 6628.933710662832, 6787.423069039187, 4188.811503482411, 4198.845317537702, 4199.559046300216, 4201.810918508613, 4207.242696314693, 5428.402875683751, 5646.407127251579, 6151.138840562236, 6434.806955791334, 6506.3818937200895, 6199.411055949678, 6207.34822843613, 6216.875662486635, 6221.4089661482085, 6239.719212635351, 5222.0, 5742.253507044057, 6162.322144564184, 6205.317415084427, 6209.782657606962, 4715.316279139574, 5355.919661205163, 5817.883642327214, 6071.028635418312, 6101.176341193882, 6234.501239900887, 6240.28236752761, 6245.219347581552, 6248.250209974832, 6265.592736472115, 5207.3490813648295, 5846.766129354778, 6044.304904935989, 6131.509479241739, 6142.836439233887], "value": 4483.795039532587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.842289427643, 645.3449748505271, 653.3499168327514, 664.1930054983194, 677.7729460630688, 14783.11729212804, 15251.618709532268, 15254.38982440701, 15295.005824621405, 15311.923440382783, 13549.93225033876, 14666.19335936523, 14704.0, 14706.117632942005, 14707.0, 900.6667533012794, 907.9863802042975, 917.3761841947473, 917.5228880981919, 920.9677661281856, 711.8718630646482, 733.3912852332578, 889.5685592487638, 922.2391526990226, 922.4142669404943, 960.9759756006085, 965.3483898368609, 968.2302569457263, 968.801395713877, 970.3062310448029, 738.65283316841, 959.2661613865398, 963.5086106085877, 964.3297907953975, 964.3635200767495, 685.7565564224728, 706.8515611721544, 707.6497133918743, 708.2457183100033, 708.9326513981215, 15185.848141518554, 15206.467773627981, 15222.543323700196, 15242.314095865713, 15251.923740381339, 12274.0, 12338.629841104781, 12483.563075292412, 12581.155111902168, 12738.426770795337, 8065.596720163969, 9821.0, 9936.90063099367, 9962.551685174185, 10183.694489165337, 3437.9656203438144, 3500.912477188065, 3587.3004764071015, 3590.120420496995, 3622.8188590570367, 74683.62658186728, 75184.87222691665, 77176.0, 77680.0, 77731.61134194293, 9354.95322523383, 9391.295652826066, 9518.095780900803, 9666.661666841626, 9992.350497217658, 21623.783762162493, 21652.35042948714, 21675.891620541795, 21711.240106596193, 21713.782862171178, 6593.3736295051895, 7401.962990185015, 7434.628268586549, 7623.35201507867, 7665.731699390494, 3979.3235150024566, 4094.3858421236455, 4106.7946602669745, 4117.114820313647, 4132.524759652619, 3397.473391624302, 3490.511328414024, 3510.526078979356, 3511.631278715749, 3516.7186625070444, 606.9362716914749, 616.5468380740152, 618.153130211613, 626.9780557680459, 641.7304732012566, 500.669558091665, 551.6469459545893, 560.95512359012, 571.9428057194248, 600.072887388985, 7522.623868806538, 7942.0, 8093.919060809434, 8138.43030987837, 8349.791255218546, 482.35605466702344, 556.9751656951229, 557.8577462746973, 605.4974371271834, 615.566025951703, 3800.562935262425, 3808.352580061396, 3823.7323387362617, 3853.679666611896, 3950.111224974415, 90888.0, 90964.0, 94645.053549465, 95558.52220738852, 96311.0368896316, 65644.37422503046, 67350.0, 71536.64231678912, 71640.28359716441, 77027.0, 67403.65192696119, 67728.85660435876, 67898.66050669814, 70070.64964675246, 70304.64847675627, 7404.555726656418, 7453.180150183584, 7624.390048795972, 7699.615019249127, 7881.684732610861, 37242.0, 38563.0, 41476.79261603673, 41542.0, 42111.7894410526, 58649.413505864395, 58825.411745882, 62005.68997154985, 63649.6817515928, 63720.68139659272, 10080.54637541327, 10231.641892533726, 10295.88934268488, 10352.53413596375, 10382.844257336297, 10946.39794811293, 11113.83329250078, 11113.944430278121, 11491.023263022737, 11519.481623327138, 10399.32404393712, 10470.319429237075, 10576.139052960209, 10773.030427261585, 10834.783304334027, 10366.5335059924, 10437.0, 10607.0, 11008.284461509977, 11518.136139789382, 10194.133498652402, 10246.846297305696, 10380.584776608852, 10637.255392122786, 10732.678019659423, 8771.342149338952, 8858.15847494487, 9017.458952462874, 9104.317176211678, 9197.080291971017, 8625.611847466753, 8801.295896328407, 8848.336374771789, 8962.551872406224, 9010.459372437412], "value": 6650.085405123512, "unit": "score"}], "name": "dromaeo_css", "value": 7211.0767698727, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 113.0, 114.0, 114.0, 119.0, 113.0, 112.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 143.0, 175.0, 153.0, 172.0, 153.0, 120.0, 168.0, 145.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 185.0, 187.0, 184.0, 185.0, 182.0, 204.0, 172.0, 260.0], "value": 193.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 79.0, 83.0, 79.0, 56.0, 58.0, 58.0, 75.0, 78.0, 56.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 131.0, 78.0, 96.0, 108.0, 155.0, 109.0, 76.0, 120.0], "value": 105.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 88.0, 91.0, 88.0, 91.0, 88.0, 91.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 100.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 88.0, 86.0, 84.0, 87.0, 84.0, 85.0, 86.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 53.0, 54.0, 54.0, 56.0, 66.0, 55.0, 52.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 74.0, 73.0, 70.0, 68.0, 68.0, 68.0, 65.0, 92.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 86.0, 85.0, 87.0, 83.0, 95.0, 111.0, 109.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 141.0, 142.0, 148.0, 154.0, 140.0, 144.0, 143.0, 146.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 182.0, 175.0, 170.0, 169.0, 173.0, 172.0, 171.0, 169.0, 170.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 87.0, 96.0, 93.0, 94.0, 69.0, 69.0, 67.0, 66.0], "value": 78.0, "unit": "score"}], "name": "kraken", "value": 1515.8999999999999, "alertThreshold": 2.0}]} 14:55:08 INFO - Return code: 0 14:55:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:55:08 ERROR - # TBPL SUCCESS # 14:55:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:08 INFO - 2016-04-09 14:55:08.105 screenresolution[1678:9982] starting screenresolution argv=screenresolution get 14:55:08 INFO - 2016-04-09 14:55:08.108 screenresolution[1678:9982] Display 0: 1600x1200x32@60 14:55:08 INFO - 2016-04-09 14:55:08.114 screenresolution[1679:9985] starting screenresolution argv=screenresolution list 14:55:08 INFO - Available Modes on Display 0 14:55:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:08 INFO - Intel Iris: 14:55:08 INFO - Chipset Model: Intel Iris 14:55:08 INFO - Type: GPU 14:55:08 INFO - Bus: Built-In 14:55:08 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:08 INFO - Vendor: Intel (0x8086) 14:55:08 INFO - Device ID: 0x0a2e 14:55:08 INFO - Revision ID: 0x0009 14:55:08 INFO - Displays: 14:55:08 INFO - Display: 14:55:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:08 INFO - Display Serial Number: 1600x1200 60 14:55:08 INFO - Main Display: Yes 14:55:08 INFO - Mirror: Off 14:55:08 INFO - Online: Yes 14:55:08 INFO - Rotation: Supported 14:55:08 INFO - Return code: 0 14:55:08 INFO - Running post-action listener: _resource_record_post_action 14:55:08 INFO - Running post-run listener: _resource_record_post_run 14:55:09 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37680640; Write bytes: 693454336; Read time: 396; Write time: 1889 14:55:09 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 385729024; Write bytes: 379901952; Read time: 29373; Write time: 720 14:55:09 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35849728; Write bytes: 298171904; Read time: 374; Write time: 1137 14:55:09 INFO - Running post-run listener: _upload_blobber_files 14:55:09 INFO - Blob upload gear active. 14:55:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:09 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 14:55:09 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'] 14:55:09 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 14:55:09 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:10 INFO - (blobuploader) - INFO - Done attempting. 14:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:55:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:11 INFO - (blobuploader) - INFO - Done attempting. 14:55:11 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:11 INFO - Return code: 0 14:55:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75a77df2f751eaad2fe8ac02b297d4785a02e48bb44b58cb0c0d1a08f3685a65efe385f0a0ff36722d5a9ad27ca9eb24221af9711fa9f3bb1f6d8c3856a719d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7474addc21026e509e5bbe6195ab8e8e58da8e5aad95d6ecec2bb9512c8047c51066b7df0395a655e4739d414b36c2a5138d5c7ad5f14fb0b5d4bcd9809aee8"} 14:55:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:11 INFO - Contents: 14:55:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/75a77df2f751eaad2fe8ac02b297d4785a02e48bb44b58cb0c0d1a08f3685a65efe385f0a0ff36722d5a9ad27ca9eb24221af9711fa9f3bb1f6d8c3856a719d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7474addc21026e509e5bbe6195ab8e8e58da8e5aad95d6ecec2bb9512c8047c51066b7df0395a655e4739d414b36c2a5138d5c7ad5f14fb0b5d4bcd9809aee8"} 14:55:11 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:11 INFO - Copying logs to upload dir... 14:55:11 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.184879 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-09 14:55:11.847281) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 14:55:11.850688) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/75a77df2f751eaad2fe8ac02b297d4785a02e48bb44b58cb0c0d1a08f3685a65efe385f0a0ff36722d5a9ad27ca9eb24221af9711fa9f3bb1f6d8c3856a719d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7474addc21026e509e5bbe6195ab8e8e58da8e5aad95d6ecec2bb9512c8047c51066b7df0395a655e4739d414b36c2a5138d5c7ad5f14fb0b5d4bcd9809aee8"} build_url:https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011545 build_url: 'https://queue.taskcluster.net/v1/task/Qmaj6ceaT8OJEvPoFXn95A/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/75a77df2f751eaad2fe8ac02b297d4785a02e48bb44b58cb0c0d1a08f3685a65efe385f0a0ff36722d5a9ad27ca9eb24221af9711fa9f3bb1f6d8c3856a719d3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e7474addc21026e509e5bbe6195ab8e8e58da8e5aad95d6ecec2bb9512c8047c51066b7df0395a655e4739d414b36c2a5138d5c7ad5f14fb0b5d4bcd9809aee8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-09 14:55:11.878171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:55:11.878507) ========= 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.hXV5XwBnlD/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.GX86Hd6KSK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-09 14:55:11.927309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 14:55:11.927629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-09 14:55:11.928046) ========= ========= Total master_lag: 0.34 =========