builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0059 starttime: 1457710054.26 results: success (0) buildid: 20160311051513 builduid: 6b8f5b1f1f254b19aa8d641be5f1a305 revision: 7feee955891b1a600f78541e69e0e6a72b32cfc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.258738) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.259228) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.259524) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005697 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.284065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.284383) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.302599) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.303049) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005205 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.352861) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.353343) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.353955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.354410) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-11 07:27:34-- 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% 15.6M=0.001s 2016-03-11 07:27:34 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169467 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.541572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.542048) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.026432 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:34.591409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:27:34.591818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7feee955891b1a600f78541e69e0e6a72b32cfc4 --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 7feee955891b1a600f78541e69e0e6a72b32cfc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-11 07:27:34,665 truncating revision to first 12 chars 2016-03-11 07:27:34,665 Setting DEBUG logging. 2016-03-11 07:27:34,665 attempt 1/10 2016-03-11 07:27:34,665 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7feee955891b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 07:27:35,761 unpacking tar archive at: fx-team-7feee955891b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334230 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 07:27:35.943099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:35.943455) ========= echo 7feee955891b1a600f78541e69e0e6a72b32cfc4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7feee955891b1a600f78541e69e0e6a72b32cfc4'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 7feee955891b1a600f78541e69e0e6a72b32cfc4 program finished with exit code 0 elapsedTime=0.005341 script_repo_revision: '7feee955891b1a600f78541e69e0e6a72b32cfc4' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:35.993037) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:35.993351) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 07:27:36.007248) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-11 07:27:36.007635) ========= /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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:27:36 INFO - MultiFileLogger online at 20160311 07:27:36 in /builds/slave/test 07:27:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:27:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:36 INFO - {'append_to_log': False, 07:27:36 INFO - 'base_work_dir': '/builds/slave/test', 07:27:36 INFO - 'blob_upload_branch': 'Fx-Team', 07:27:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:36 INFO - 'branch': 'Fx-Team', 07:27:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:36 INFO - 'config_files': ('talos/mac_config.py',), 07:27:36 INFO - 'default_actions': ('clobber', 07:27:36 INFO - 'read-buildbot-config', 07:27:36 INFO - 'download-and-extract', 07:27:36 INFO - 'populate-webroot', 07:27:36 INFO - 'create-virtualenv', 07:27:36 INFO - 'install', 07:27:36 INFO - 'run-tests'), 07:27:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:36 INFO - 'download_minidump_stackwalk': True, 07:27:36 INFO - 'download_symbols': 'ondemand', 07:27:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:36 INFO - 'installer_path': 'installer.exe', 07:27:36 INFO - 'log_level': 'info', 07:27:36 INFO - 'log_name': 'talos', 07:27:36 INFO - 'log_to_console': True, 07:27:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:27:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:27:36 INFO - 'opt_config_files': (), 07:27:36 INFO - 'pip_index': False, 07:27:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:36 INFO - 'cmd': ('bash', 07:27:36 INFO - '-c', 07:27:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:36 INFO - 'enabled': True, 07:27:36 INFO - 'halt_on_failure': False, 07:27:36 INFO - 'name': 'check_screen_resolution'},), 07:27:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:36 INFO - 'cmd': ('bash', 07:27:36 INFO - '-c', 07:27:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:36 INFO - 'enabled': True, 07:27:36 INFO - 'halt_on_failure': False, 07:27:36 INFO - 'name': 'check_screen_resolution'},), 07:27:36 INFO - 'run_cmd_checks_enabled': True, 07:27:36 INFO - 'sps_profile': False, 07:27:36 INFO - 'sps_profile_interval': 0, 07:27:36 INFO - 'suite': 'dromaeojs', 07:27:36 INFO - 'system_bits': '32', 07:27:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:36 INFO - 'title': 't-yosemite-r7-0059', 07:27:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:36 INFO - 'use_talos_json': True, 07:27:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:36 INFO - 'work_dir': 'build'} 07:27:36 INFO - ##### 07:27:36 INFO - ##### Running clobber step. 07:27:36 INFO - ##### 07:27:36 INFO - Running pre-action listener: _resource_record_pre_action 07:27:36 INFO - Running main action method: clobber 07:27:36 INFO - rmtree: /builds/slave/test/build 07:27:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:37 INFO - Running post-action listener: _resource_record_post_action 07:27:37 INFO - ##### 07:27:37 INFO - ##### Running read-buildbot-config step. 07:27:37 INFO - ##### 07:27:37 INFO - Running pre-action listener: _resource_record_pre_action 07:27:37 INFO - Running main action method: read_buildbot_config 07:27:37 INFO - Using buildbot properties: 07:27:37 INFO - { 07:27:37 INFO - "project": "", 07:27:37 INFO - "product": "firefox", 07:27:37 INFO - "script_repo_revision": "production", 07:27:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:27:37 INFO - "repository": "", 07:27:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:27:37 INFO - "buildid": "20160311051513", 07:27:37 INFO - "pgo_build": "False", 07:27:37 INFO - "basedir": "/builds/slave/test", 07:27:37 INFO - "buildnumber": 526, 07:27:37 INFO - "slavename": "t-yosemite-r7-0059", 07:27:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:27:37 INFO - "platform": "yosemite_r7", 07:27:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:27:37 INFO - "branch": "fx-team", 07:27:37 INFO - "repo_path": "integration/fx-team", 07:27:37 INFO - "revision": "7feee955891b1a600f78541e69e0e6a72b32cfc4", 07:27:37 INFO - "stage_platform": "macosx64", 07:27:37 INFO - "builduid": "6b8f5b1f1f254b19aa8d641be5f1a305", 07:27:37 INFO - "slavebuilddir": "test" 07:27:37 INFO - } 07:27:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:27:37 INFO - Running post-action listener: _resource_record_post_action 07:27:37 INFO - ##### 07:27:37 INFO - ##### Running download-and-extract step. 07:27:37 INFO - ##### 07:27:37 INFO - Running pre-action listener: _resource_record_pre_action 07:27:37 INFO - Running main action method: download_and_extract 07:27:37 INFO - mkdir: /builds/slave/test/build/tests 07:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:37 INFO - https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:27:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:27:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:27:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:27:39 INFO - Downloaded 1199 bytes. 07:27:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:27:39 INFO - Using the following test package requirements: 07:27:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:27:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:27:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:27:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'jsshell-mac.zip'], 07:27:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:27:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:27:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:27:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:27:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:27:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:27:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:27:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:27:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:39 INFO - https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:27:40 INFO - Downloaded 17867599 bytes. 07:27:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:27:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:27:43 INFO - Return code: 0 07:27:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:43 INFO - https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:27:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:27:44 INFO - Downloaded 17867599 bytes. 07:27:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:27:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:27:47 INFO - Return code: 0 07:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:47 INFO - https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:27:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:27:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:27:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:27:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:27:48 INFO - Downloaded 10845161 bytes. 07:27:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:27:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:27:48 INFO - Return code: 0 07:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:48 INFO - https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:27:51 INFO - Downloaded 111003030 bytes. 07:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:27:51 INFO - mkdir: /builds/slave/test/properties 07:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:51 INFO - Contents: 07:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:27:52 INFO - Running post-action listener: _resource_record_post_action 07:27:52 INFO - Running post-action listener: set_extra_try_arguments 07:27:52 INFO - ##### 07:27:52 INFO - ##### Running populate-webroot step. 07:27:52 INFO - ##### 07:27:52 INFO - Running pre-action listener: _resource_record_pre_action 07:27:52 INFO - Running main action method: populate_webroot 07:27:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:52 INFO - '--tppagecycles', 07:27:52 INFO - '7'], 07:27:52 INFO - 'tests': ['tsvgm']}}, 07:27:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:27:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:27:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'tests': ['damp', 'tps']}, 07:27:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['damp', 'tps']}, 07:27:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:27:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:52 INFO - 'other': {'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'other_l64': {'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'other_nol64': {'tests': ['a11yr', 07:27:52 INFO - 'ts_paint', 07:27:52 INFO - 'tpaint', 07:27:52 INFO - 'sessionrestore', 07:27:52 INFO - 'sessionrestore_no_auto_restore', 07:27:52 INFO - 'tabpaint']}, 07:27:52 INFO - 'svgr': {'tests': ['tsvgx', 07:27:52 INFO - 'tsvgr_opacity', 07:27:52 INFO - 'tart', 07:27:52 INFO - 'tscrollx', 07:27:52 INFO - 'cart']}, 07:27:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['tsvgx', 07:27:52 INFO - 'tsvgr_opacity', 07:27:52 INFO - 'tart', 07:27:52 INFO - 'tscrollx', 07:27:52 INFO - 'cart']}, 07:27:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'tests': ['tp5o']}, 07:27:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'talos_options': ['--e10s'], 07:27:52 INFO - 'tests': ['tp5o']}, 07:27:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'talos_options': ['--xperf_path', 07:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:52 INFO - 'tests': ['tp5n']}, 07:27:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:52 INFO - 'talos_options': ['--e10s', 07:27:52 INFO - '--xperf_path', 07:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:52 INFO - 'tests': ['tp5n']}}, 07:27:52 INFO - 'talos.zip': {'path': '', 07:27:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:52 INFO - Running post-action listener: _resource_record_post_action 07:27:52 INFO - ##### 07:27:52 INFO - ##### Running create-virtualenv step. 07:27:52 INFO - ##### 07:27:52 INFO - Running pre-action listener: _resource_record_pre_action 07:27:52 INFO - Running main action method: create_virtualenv 07:27:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:27:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:52 INFO - Using real prefix '/tools/python27' 07:27:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:56 INFO - Installing pip.................done. 07:27:56 INFO - Return code: 0 07:27:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:56 INFO - 'HOME': '/Users/cltbld', 07:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:56 INFO - 'LOGNAME': 'cltbld', 07:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:56 INFO - 'MOZ_NO_REMOTE': '1', 07:27:56 INFO - 'NO_EM_RESTART': '1', 07:27:56 INFO - 'PAGER': '/bin/cat', 07:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:56 INFO - 'PWD': '/builds/slave/test', 07:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:56 INFO - 'SHELL': '/bin/bash', 07:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:27:56 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:56 INFO - 'USER': 'cltbld', 07:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:56 INFO - 'XPC_FLAGS': '0x0', 07:27:56 INFO - 'XPC_SERVICE_NAME': '0', 07:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:27:56 INFO - Cleaning up... 07:27:56 INFO - Return code: 0 07:27:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:56 INFO - 'HOME': '/Users/cltbld', 07:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:56 INFO - 'LOGNAME': 'cltbld', 07:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:56 INFO - 'MOZ_NO_REMOTE': '1', 07:27:56 INFO - 'NO_EM_RESTART': '1', 07:27:56 INFO - 'PAGER': '/bin/cat', 07:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:56 INFO - 'PWD': '/builds/slave/test', 07:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:56 INFO - 'SHELL': '/bin/bash', 07:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:27:56 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:56 INFO - 'USER': 'cltbld', 07:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:56 INFO - 'XPC_FLAGS': '0x0', 07:27:56 INFO - 'XPC_SERVICE_NAME': '0', 07:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:56 INFO - Downloading/unpacking psutil>=0.7.1 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:59 INFO - Installing collected packages: psutil 07:27:59 INFO - Running setup.py install for psutil 07:27:59 INFO - building 'psutil._psutil_osx' extension 07:27:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:27:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:28:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:28:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:28:00 INFO - building 'psutil._psutil_posix' extension 07:28:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:28:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:28:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:28:00 INFO - ^ 07:28:00 INFO - 1 warning generated. 07:28:00 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:28:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:28:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:28:00 INFO - Successfully installed psutil 07:28:00 INFO - Cleaning up... 07:28:00 INFO - Return code: 0 07:28:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:00 INFO - 'HOME': '/Users/cltbld', 07:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:00 INFO - 'LOGNAME': 'cltbld', 07:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:00 INFO - 'MOZ_NO_REMOTE': '1', 07:28:00 INFO - 'NO_EM_RESTART': '1', 07:28:00 INFO - 'PAGER': '/bin/cat', 07:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:00 INFO - 'PWD': '/builds/slave/test', 07:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:00 INFO - 'SHELL': '/bin/bash', 07:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:00 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:00 INFO - 'USER': 'cltbld', 07:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:00 INFO - 'XPC_FLAGS': '0x0', 07:28:00 INFO - 'XPC_SERVICE_NAME': '0', 07:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:28:03 INFO - Installing collected packages: mozsystemmonitor 07:28:03 INFO - Running setup.py install for mozsystemmonitor 07:28:03 INFO - Successfully installed mozsystemmonitor 07:28:03 INFO - Cleaning up... 07:28:03 INFO - Return code: 0 07:28:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:03 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:03 INFO - 'HOME': '/Users/cltbld', 07:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:03 INFO - 'LOGNAME': 'cltbld', 07:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:03 INFO - 'MOZ_NO_REMOTE': '1', 07:28:03 INFO - 'NO_EM_RESTART': '1', 07:28:03 INFO - 'PAGER': '/bin/cat', 07:28:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:03 INFO - 'PWD': '/builds/slave/test', 07:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:03 INFO - 'SHELL': '/bin/bash', 07:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:03 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:03 INFO - 'USER': 'cltbld', 07:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:03 INFO - 'XPC_FLAGS': '0x0', 07:28:03 INFO - 'XPC_SERVICE_NAME': '0', 07:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:28:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:07 INFO - Downloading docopt-0.6.1.tar.gz 07:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:28:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:28:07 INFO - Running setup.py install for blobuploader 07:28:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:28:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:28:07 INFO - Running setup.py install for requests 07:28:07 INFO - Running setup.py install for docopt 07:28:08 INFO - Successfully installed blobuploader requests docopt 07:28:08 INFO - Cleaning up... 07:28:08 INFO - Return code: 0 07:28:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:08 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:08 INFO - 'HOME': '/Users/cltbld', 07:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:08 INFO - 'LOGNAME': 'cltbld', 07:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:08 INFO - 'MOZ_NO_REMOTE': '1', 07:28:08 INFO - 'NO_EM_RESTART': '1', 07:28:08 INFO - 'PAGER': '/bin/cat', 07:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:08 INFO - 'PWD': '/builds/slave/test', 07:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:08 INFO - 'SHELL': '/bin/bash', 07:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:08 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:08 INFO - 'USER': 'cltbld', 07:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:08 INFO - 'XPC_FLAGS': '0x0', 07:28:08 INFO - 'XPC_SERVICE_NAME': '0', 07:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-iRJlsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-eKORG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:08 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-XXgYFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-laJ5gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-ZZEBto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-deVhmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-h6461g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-WmBbNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-4kbEG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-a6jcJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Xa0fDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:09 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-dRTcE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:10 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-0RGa02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:10 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-IZ3zQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:10 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-B1oQ82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:10 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-rOkzbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:10 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_j9chR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:10 INFO - Running setup.py install for manifestparser 07:28:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:10 INFO - Running setup.py install for mozcrash 07:28:10 INFO - Running setup.py install for mozdebug 07:28:10 INFO - Running setup.py install for mozdevice 07:28:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozfile 07:28:11 INFO - Running setup.py install for mozhttpd 07:28:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozinfo 07:28:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozInstall 07:28:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:11 INFO - Running setup.py install for mozleak 07:28:11 INFO - Running setup.py install for mozlog 07:28:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for moznetwork 07:28:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozprocess 07:28:12 INFO - Running setup.py install for mozprofile 07:28:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozrunner 07:28:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:12 INFO - Running setup.py install for mozscreenshot 07:28:12 INFO - Running setup.py install for moztest 07:28:12 INFO - Running setup.py install for mozversion 07:28:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:13 INFO - Cleaning up... 07:28:13 INFO - Return code: 0 07:28:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:13 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:13 INFO - 'HOME': '/Users/cltbld', 07:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:13 INFO - 'LOGNAME': 'cltbld', 07:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:13 INFO - 'MOZ_NO_REMOTE': '1', 07:28:13 INFO - 'NO_EM_RESTART': '1', 07:28:13 INFO - 'PAGER': '/bin/cat', 07:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:13 INFO - 'PWD': '/builds/slave/test', 07:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:13 INFO - 'SHELL': '/bin/bash', 07:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:13 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:13 INFO - 'USER': 'cltbld', 07:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:13 INFO - 'XPC_FLAGS': '0x0', 07:28:13 INFO - 'XPC_SERVICE_NAME': '0', 07:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-x2EFJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-XKps8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:13 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qMhwG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qRVhhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-LvSuQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_5_eOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-L7Lqwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Wr_S8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-8zrFwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-FxHTtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-OHEI9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:28:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:14 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-hMtsFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:15 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-drfw2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:15 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Y6QDbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:15 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-hqmve_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:15 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-4S2j1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:28:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:15 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_vVmvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:17 INFO - Downloading blessings-1.6.tar.gz 07:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:18 INFO - Installing collected packages: blessings 07:28:18 INFO - Running setup.py install for blessings 07:28:18 INFO - Successfully installed blessings 07:28:18 INFO - Cleaning up... 07:28:18 INFO - Return code: 0 07:28:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:18 INFO - Reading from file tmpfile_stdout 07:28:18 INFO - Current package versions: 07:28:18 INFO - blessings == 1.6 07:28:18 INFO - blobuploader == 1.2.4 07:28:18 INFO - docopt == 0.6.1 07:28:18 INFO - manifestparser == 1.1 07:28:18 INFO - mozInstall == 1.12 07:28:18 INFO - mozcrash == 0.17 07:28:18 INFO - mozdebug == 0.1 07:28:18 INFO - mozdevice == 0.48 07:28:18 INFO - mozfile == 1.2 07:28:18 INFO - mozhttpd == 0.7 07:28:18 INFO - mozinfo == 0.9 07:28:18 INFO - mozleak == 0.1 07:28:18 INFO - mozlog == 3.1 07:28:18 INFO - moznetwork == 0.27 07:28:18 INFO - mozprocess == 0.22 07:28:18 INFO - mozprofile == 0.28 07:28:18 INFO - mozrunner == 6.11 07:28:18 INFO - mozscreenshot == 0.1 07:28:18 INFO - mozsystemmonitor == 0.0 07:28:18 INFO - moztest == 0.7 07:28:18 INFO - mozversion == 1.4 07:28:18 INFO - psutil == 3.1.1 07:28:18 INFO - requests == 1.2.3 07:28:18 INFO - wsgiref == 0.1.2 07:28:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:18 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:18 INFO - 'HOME': '/Users/cltbld', 07:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:18 INFO - 'LOGNAME': 'cltbld', 07:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:18 INFO - 'MOZ_NO_REMOTE': '1', 07:28:18 INFO - 'NO_EM_RESTART': '1', 07:28:18 INFO - 'PAGER': '/bin/cat', 07:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:18 INFO - 'PWD': '/builds/slave/test', 07:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:18 INFO - 'SHELL': '/bin/bash', 07:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:18 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:18 INFO - 'USER': 'cltbld', 07:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:18 INFO - 'XPC_FLAGS': '0x0', 07:28:18 INFO - 'XPC_SERVICE_NAME': '0', 07:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:18 INFO - Cleaning up... 07:28:18 INFO - Return code: 0 07:28:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28: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')]} 07:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28: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')]} 07:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:18 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:18 INFO - 'HOME': '/Users/cltbld', 07:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:18 INFO - 'LOGNAME': 'cltbld', 07:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:18 INFO - 'MOZ_NO_REMOTE': '1', 07:28:18 INFO - 'NO_EM_RESTART': '1', 07:28:18 INFO - 'PAGER': '/bin/cat', 07:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:18 INFO - 'PWD': '/builds/slave/test', 07:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:18 INFO - 'SHELL': '/bin/bash', 07:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:18 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:18 INFO - 'USER': 'cltbld', 07:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:18 INFO - 'XPC_FLAGS': '0x0', 07:28:18 INFO - 'XPC_SERVICE_NAME': '0', 07:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:19 INFO - Downloading/unpacking jsonschema 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:21 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:22 INFO - warning: no files found matching '*.txt' 07:28:22 INFO - no previously-included directories found matching 'build' 07:28:22 INFO - no previously-included directories found matching 'dist' 07:28:22 INFO - no previously-included directories found matching '.git*' 07:28:22 INFO - Installing collected packages: jsonschema, functools32 07:28:22 INFO - Running setup.py install for functools32 07:28:22 INFO - warning: no files found matching '*.txt' 07:28:22 INFO - no previously-included directories found matching 'build' 07:28:22 INFO - no previously-included directories found matching 'dist' 07:28:22 INFO - no previously-included directories found matching '.git*' 07:28:22 INFO - Successfully installed jsonschema functools32 07:28:22 INFO - Cleaning up... 07:28:22 INFO - Return code: 0 07:28:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:22 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 0x10bf75a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bf7d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7c3cdb880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, '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.j01Hsx6HDy/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.MtfkvvsP19/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:22 INFO - 'HOME': '/Users/cltbld', 07:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:22 INFO - 'LOGNAME': 'cltbld', 07:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:22 INFO - 'MOZ_NO_REMOTE': '1', 07:28:22 INFO - 'NO_EM_RESTART': '1', 07:28:22 INFO - 'PAGER': '/bin/cat', 07:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:22 INFO - 'PWD': '/builds/slave/test', 07:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:22 INFO - 'SHELL': '/bin/bash', 07:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:28:22 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:22 INFO - 'USER': 'cltbld', 07:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:22 INFO - 'XPC_FLAGS': '0x0', 07:28:22 INFO - 'XPC_SERVICE_NAME': '0', 07:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:22 INFO - Downloading/unpacking flake8 07:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:26 INFO - no previously-included directories found matching 'docs/_build' 07:28:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:26 INFO - Running setup.py install for pep8 07:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:26 INFO - no previously-included directories found matching 'docs/_build' 07:28:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:26 INFO - Cleaning up... 07:28:26 INFO - Return code: 0 07:28:26 INFO - Running post-action listener: _resource_record_post_action 07:28:26 INFO - Running post-action listener: _start_resource_monitoring 07:28:26 INFO - Starting resource monitoring. 07:28:26 INFO - ##### 07:28:26 INFO - ##### Running install step. 07:28:26 INFO - ##### 07:28:26 INFO - Running pre-action listener: _resource_record_pre_action 07:28:26 INFO - Running main action method: install 07:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:26 INFO - Reading from file tmpfile_stdout 07:28:26 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:27 INFO - Reading from file tmpfile_stdout 07:28:27 INFO - Output received: 07:28:27 INFO - Usage: mozinstall [options] installer 07:28:27 INFO - Options: 07:28:27 INFO - -h, --help show this help message and exit 07:28:27 INFO - -d DEST, --destination=DEST 07:28:27 INFO - Directory to install application into. [default: 07:28:27 INFO - "/builds/slave/test"] 07:28:27 INFO - --app=APP Application being installed. [default: firefox] 07:28:27 INFO - mkdir: /builds/slave/test/build/application 07:28:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:29:00 INFO - Reading from file tmpfile_stdout 07:29:00 INFO - Output received: 07:29:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:29:00 INFO - Running post-action listener: _resource_record_post_action 07:29:00 INFO - ##### 07:29:00 INFO - ##### Running run-tests step. 07:29:00 INFO - ##### 07:29:00 INFO - Running pre-action listener: _resource_record_pre_action 07:29:00 INFO - Running main action method: run_tests 07:29:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:29:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:29:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:29:00 INFO - 2016-03-11 07:29:00.924 screenresolution[1649:7489] starting screenresolution argv=screenresolution get 07:29:00 INFO - 2016-03-11 07:29:00.926 screenresolution[1649:7489] Display 0: 1600x1200x32@60 07:29:00 INFO - 2016-03-11 07:29:00.932 screenresolution[1650:7491] starting screenresolution argv=screenresolution list 07:29:00 INFO - Available Modes on Display 0 07:29:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:29:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:29:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:29:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:29:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:29:01 INFO - Intel Iris: 07:29:01 INFO - Chipset Model: Intel Iris 07:29:01 INFO - Type: GPU 07:29:01 INFO - Bus: Built-In 07:29:01 INFO - VRAM (Dynamic, Max): 1536 MB 07:29:01 INFO - Vendor: Intel (0x8086) 07:29:01 INFO - Device ID: 0x0a2e 07:29:01 INFO - Revision ID: 0x0009 07:29:01 INFO - Displays: 07:29:01 INFO - Display: 07:29:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:29:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:29:01 INFO - Display Serial Number: 1600x1200 60 07:29:01 INFO - Main Display: Yes 07:29:01 INFO - Mirror: Off 07:29:01 INFO - Online: Yes 07:29:01 INFO - Rotation: Supported 07:29:01 INFO - Return code: 0 07:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:01 INFO - Python 2.7.3 07:29:01 INFO - Return code: 0 07:29:01 INFO - grabbing minidump binary from tooltool 07:29:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:29:01 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 0x10be19d30>, '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 0x10bc3ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be10b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:29:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:29:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:01 INFO - Return code: 0 07:29:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:29:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:29:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:29:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:29:02 INFO - Return code: 0 07:29:02 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/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:29:02 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/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:29:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.j01Hsx6HDy/Render', 07:29:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:29:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:29:02 INFO - 'HOME': '/Users/cltbld', 07:29:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:29:02 INFO - 'LOGNAME': 'cltbld', 07:29:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:02 INFO - 'MOZ_NO_REMOTE': '1', 07:29:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:02 INFO - 'NO_EM_RESTART': '1', 07:29:02 INFO - 'PAGER': '/bin/cat', 07:29:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:02 INFO - 'PWD': '/builds/slave/test', 07:29:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:29:02 INFO - 'SHELL': '/bin/bash', 07:29:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtfkvvsP19/Listeners', 07:29:02 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 07:29:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:29:02 INFO - 'USER': 'cltbld', 07:29:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:29:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:02 INFO - 'XPC_FLAGS': '0x0', 07:29:02 INFO - 'XPC_SERVICE_NAME': '0', 07:29:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:29:02 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/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:29:02 INFO - mozversion application_buildid: 20160311051513 07:29:02 INFO - mozversion application_changeset: 7feee955891b1a600f78541e69e0e6a72b32cfc4 07:29:02 INFO - mozversion application_display_name: Nightly 07:29:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:02 INFO - mozversion application_name: Firefox 07:29:02 INFO - mozversion application_remotingname: firefox 07:29:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:29:02 INFO - mozversion application_vendor: Mozilla 07:29:02 INFO - mozversion application_version: 48.0a1 07:29:02 INFO - mozversion platform_buildid: 20160311051513 07:29:02 INFO - mozversion platform_changeset: 7feee955891b1a600f78541e69e0e6a72b32cfc4 07:29:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:29:02 INFO - mozversion platform_version: 48.0a1 07:29:02 INFO - using testdate: 1457710142 07:29:02 INFO - actual date: 1457710142 07:29:02 INFO - starting webserver on 'localhost:49270' 07:29:02 INFO - SUITE-START | Running 2 tests 07:29:02 INFO - TEST-START | dromaeo_css 07:29:02 INFO - operating with platform_type : mac_ 07:29:02 INFO - Initialising browser for dromaeo_css test... 07:29:02 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpTDZvwL/profile http://localhost:49270/getInfo.html) 07:29:05 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 07:29:05 INFO - PROCESS | 1671 | colorDepth:24 07:29:05 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 07:29:05 INFO - PROCESS | 1671 | __metrics 07:29:05 INFO - PROCESS | 1671 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:29:05 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:29:05 INFO - TEST-INFO | 1671: exit 0 07:29:05 INFO - Browser initialized. 07:29:05 INFO - Running cycle 1/1 for dromaeo_css test... 07:29:05 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpTDZvwL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:17 INFO - PROCESS | 1673 | RSS: Main: 242991104 07:29:17 INFO - PROCESS | 1673 | 07:30:08 INFO - PROCESS | 1673 | 1457710208428 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] 07:32:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 07:32:20 INFO - PROCESS | 1673 | RSS: Main: 405233664 07:32:20 INFO - PROCESS | 1673 | 07:35:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 07:35:23 INFO - PROCESS | 1673 | RSS: Main: 373698560 07:35:23 INFO - PROCESS | 1673 | 07:38:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 07:38:26 INFO - PROCESS | 1673 | RSS: Main: 376487936 07:38:26 INFO - PROCESS | 1673 | 07:41:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 07:41:28 INFO - PROCESS | 1673 | RSS: Main: 333291520 07:41:28 INFO - PROCESS | 1673 | 07:44:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 07:44:32 INFO - PROCESS | 1673 | RSS: Main: 339341312 07:44:32 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 07:47:35 INFO - PROCESS | 1673 | RSS: Main: 412393472 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | __start_tp_report 07:47:35 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 07:47:35 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 07:47:35 INFO - PROCESS | 1673 | |i|pagename|runs| 07:47:35 INFO - PROCESS | 1673 | |0;dojo.html;2917.2415172055257;3406.1314364836967;3459.4464885618304;3482.791032538048;3532.046347486179;5461.617686761928;5544.085225937715;5590;5590.608657393979;5607.186957891108;5581.8604534886645;5614.073677843161;5650.886982260352;5703.57223208259;5739.598228124033;4996.5503104720565;5024.371953505812;5029.421616514092;5062.417821950467;5179.948200517984;5119.308893299394;5128.53843154116;5167.354080739908;5169.508896654812;5171.87070323243;4978.999999999982;4997.950020499785;5085.542301192873;5093.312402825608;5122.615803814729;5052.69683818972;5065.518775716301;5081.110805609041;5084.389873215201;5101.107306221434;4982;5012.749362531858;5027.170516864713;5036.093503169464;5051.343325367716;5366.114591092465;5463.836084917459;5470;5548.944510554924;5554.2779438673115;6145.907811382833;6165.383461653843;6170.2904166021035;6173.074038894157;6176.351483094255;6168.87662246757;6221.564490485668;6222.626642401425;6232.376762323776;6239.37606239377;5547.3343198816;5653.067243904751;5658.745356458928;5762.481376676119;5768.2501274834;6249.500039996789;6253.624782513064;6256.562040657111;6260.780872669435;6274;6011.308699499614;6019.307779605401;6053.727582258809;6072.666003369769;6099.329073801879;6043.667598282049;6121.422488707842;6127.311699317065;6177.938220617826;6207.689615519206;6111.755529778759;6118.388161183846;6119.197913140505;6122.1338301444075;6127.6782420562195;6160.260768707694;6168.506519478431;6174.536909731788;6184.134221209034;6203.410675985774;4326.610605045561;4540.751293394277;4734.19518681818;4788.928166077511;4865.172920603506;4354.695171337976;4355.1725172217175;4387.692861499664;4391.604755572014;4400.427944367276;5579.358373786985;5643.661380317112;5654.208410822488;5670.234518340054;5675.631083979611;6223.844403889939;6232.065190221412;6232.158658581124;6239.719212635442;6248.094026366151;5431.646942948696;5614.747336369873;5628.60599758013;5633.690147041952;5637.7181140942785;5193;5234.26720259164;5241.528262456397;5266.289050978069;5273.815416460406;6209.782657606962;6218.533609979179;6222;6224.097505861625;6232.220972378453;6009.308929472992;6184.5052395809125;6191.071339299141;6224.875502490016;6233.968830156002;6177.660228687286;6206.906896396467;6218.06728990655;6223.37766223374;6252.718627661675;6083.452489275986;6100.389961003864;6110;6112.346079876185;6112.74665817949;6001;6011.128386384037;6157.907631385622;6163.876722465436;6169.753209871555;5893.793717219876;5911.113333000085;5983.730732116978;6043.486303664238;6048.758049678139;5951.196588460502;5984.371640977634;5996.130561068708;6029.51763858899;6031.879362412639;5704.429557044428;5839.941600583939;5866.208061911758;5866.794662186803;5877;5893.852653683521;5904.3210030847;5923.4076592340425;5933.762649493972;5935.7032148391545;5765.250517432707;5767.048437007847;5771.394003629726;5784.566157538117;5789.710514474175 07:47:35 INFO - PROCESS | 1673 | |1;ext.html;462.36194052207946;570.7842295909712;573.9496721000569;640.4876099120704;642.8907085795415;37978.620213797854;39093.02267443315;39093.41359879597;39140;39144.804275978655;41762.7911860441;42177;42317.788411057976;42376.36435453471;42413.57586424142;9584.56869440875;9751.951240243789;9768.974257702945;9773.951130244339;9778.364406313567;9628.951855240713;9786.951065244664;9791.412515249072;9794.118529332358;9800.803983920317;9871.407715537054;9945.408734602464;9949.651762188325;9952.054554817281;9952.054554817318;9802.2158227342;9874.9506252469;9875.555599998017;9883.851742223873;9889.75275618108;8782.516961567175;9449.43303401798;9630.3258771886;9785.168260697848;9790.461524616143;40881.386779198336;41350.79324603388;41443;41536.792316038525;41563;3177.205698575356;3253.3655937092276;3416.7095796857298;3466.6706662866986;3497.7376696747847;25152.868120934603;26723;27238.863805680845;28820.855895720386;28925.276868078465;2708.065717327519;2796.1331987083868;2825.2371859597997;2879.5536691812804;2972.613560237177;386965;391125.99999999715;391222.99999999715;391650;392164;65089.023664645065;65535;69714.9542756849;69831.65084174546;69926.65036674784;73658.63170684113;73674.6316268426;73777.6311118441;73966.63016684882;74263;15674.373025079098;17377.91311043462;17588.592912566965;17605.38381156679;17614.647707045788;11786.88213117875;11809.52761889532;11873.643790686294;13168.802467962989;13448.529301474597;16265.496598866113;20708.689369659467;21072.683909741365;21180;21216.575668486545;9325.067493250757;9436.575354109082;9558.56986435612;9580.473073980998;9619.470929098967;938.7653086728318;998.3111652959435;1019.3832731197518;1119.2556949628406;1203.4163430736087;28508.859645614357;28545.857270713514;29421.55867661987;29962.55056174159;30051.398972020874;1117.2626066795876;1162.4304090995352;1185.1940680337452;1202.4468744377684;1247.8190662354089;14892.70214595702;15086.54740357791;15150.16674082936;15400.46098386551;15481.767773483407;439126;443281;445919;445926;445996;58499.70750146222;59105.704471477366;59128;59226;59229;1342.8455727591256;1414.1868425655289;1444.5377479206552;1445.5302026841318;1482.9110253384831;25968.8701556491;28762.712372876;28918.566221506273;29305.706942930297;29864.25339366446;47290;48053.75973120112;48370.5162948366;48386;48550.271745923135;352146;355221.22389387887;355380;355528;355648;23520.764792352544;28826.135215943556;32684.673153268162;33312.666873330956;33636.49545256872;43968.34047489226;44239.336409953234;44511.10977780491;44823.77588112038;45604.771976139906;34678.65321346754;36615.816920915226;37150;37542;37663.0816516642;28082.57876131819;29235.7076429233;35603.465948010286;36101.81949090238;37006.44490332701;35506.822465887504;35988.10029749277;36361.45457818082;36836.63163368332;36885.631143689294;31149.377012459172;31607.19103818358;32113.8394308027;32189.839050804596;32568.223029237142;24281.63577546303;24476.758092807795;24604.507909841344;24652;24733.62899556544 07:47:35 INFO - PROCESS | 1673 | |2;jquery.html;336.9285671564425;355.28410253339524;360.4485137739258;362.45450596851737;363.77082438064014;20078.397648070546;20619.484512887186;21521.784782152194;21969.23107691231;22019.449513762163;11674.066074714025;12053.698657533567;12065.3967301635;12074.698132546691;12092.455839487244;5126.718030508339;5161.27742116104;5371.785128594852;5392.352917649888;5395.7032363220005;5279.155335146377;5293.708846013467;5305.495977882095;5319.414864364917;5338.866528336784;5335.119705248649;5337.332833395825;5339.519443250107;5550.417206193352;5830.737616807254;5711.171880077386;5720.256366672347;5757.65454072757;5758.798442054529;5761.88476230473;4592.678512504126;5453.590980676426;5510.173473978895;5523.558115350762;5633.8309850704545;23494.29517114489;23834;24066.759332406626;25268.620970685453;25292.620610690854;2026.878387296767;2054.4488317548953;2151.612709712251;2262.827740003274;2521.848689078661;9740.415575065519;9789.804203915883;10115.190784737204;12851.228926264454;14275.286235688174;1655.0979716054778;1722.0872937343229;1779.288284686123;1811.7644706188112;1851.6666999940005;80257.99999999942;106438.46780766046;106627;107156.4642176792;107232.46383768109;11248.381339026431;11287.54849806015;11432.199746017699;11435.199536032564;11543.480543375568;13786.862131378759;13876.959228057734;13887;13916.791248131287;13929.23389213603;8484.618192181366;8661.393702440895;8675.479471231747;8767.605457754416;8772.105205282242;8836.204741573289;8851.64593416269;8886.911130888608;8967.668406214301;8973.19241268276;4441.289393696993;4523;4523.050159466549;4563.612092972135;4581.496035436099;1858.7862395824384;1901.1729897494633;1906.8474522038205;1916.3963351544219;1930.893800840939;871.333429926107;911.4030310146865;978.5792109393029;984.5667906121427;1027.6249169053392;18929;19722.50693732668;19766.802331976785;19845.404637860887;19918.402447926586;783.9098503672037;785.6229010075195;956.4404823178519;956.5934477847027;1007.5466040281902;7493.3256006958545;10549.367037977747;10592.682219533426;10606;10790.622328218475;496741;506421;507006.46496767283;545586;596703;110706;112883;125884;131547;132286;854.7777577829809;969.7236287657984;1002.756581838515;1007.4761124215366;1039.5374058544026;13546.187228766306;16999.81001329895;17586.03276819787;17703.291868325123;17870.642587147926;54040.45959540354;54128;54190.458095418544;55011.72494137504;55039;68497;73355;76398;79761;79798.60100699459;7871.921280787119;8030.478018928751;8068.99137607799;8152.470089444168;8383.664653413794;12076.75846483083;13142.671433213864;13238.867611323763;13543.86456135426;13577.456901723821;11237.38194399316;11516.251443656136;11591.478383472933;11623.244489108181;11673.766524669629;9247.393516528693;11331.206815522833;11454.541818327174;11618.0705543558;11683.707907302385;11373.090152787923;11405.486753095965;11536.25014374063;11720.824187637021;11950.581729639422;7853.489523180975;8050.677972881019;8063.8790418144945;8133.308668763221;8367.790805229917;10563.683089507327;10976.835347469634;11031.007209351197;11400.087992960378;11687 07:47:35 INFO - PROCESS | 1673 | |3;mootools.html;1280.8591054983945;1404.382071888369;1640.8523232909035;1843.2903332217102;1883.7645294338208;7289.744858929932;7480.364169045624;7964.641591128398;8710.303175745941;8757.956210218948;8445.831083378343;8699.173578510046;8722.389432739696;8730.476171429718;8788.2969362451;2180.1170525937023;2423.5758742220128;2472.7774500295013;2486.7140278867982;2505.5991041433376;2424.018272599591;2424.3939015246187;2431.088341871798;2431.525852458771;2433.4403087289934;2434.6956630421196;2468.8024958003407;2491.813114016447;2495.6381324707904;2501.0746023971155;2116.75657299411;2424.090965887792;2480.7519248075137;2484.142970675114;2485.3413845331;2105.673620588796;2451.681281433402;2498.3254521279155;2502.5995840665405;2503.4116982509095;8790.384673072887;8867.423617464845;8876.733697989072;8882.467051976902;8882.955585222096;5356.973215133899;5538.446155384469;5549.833504994856;5553.139263414137;5595.580331475115;3579.480975258599;3682.797446140461;3702.796591107901;3736.5889752127246;3740.6259374062647;1030.3560274828233;1035.377898013785;1039.3452125161175;1043.9582416703322;1057.0750593230923;11873.346965916871;11877.524899004116;11882.821757673642;11903.702407439796;11947.103967202494;4225.788710564521;4752.1683705351425;4910.877228069256;5009;5016.297718319438;10080.949595252123;10088.293819432569;10091.848622270672;10094.646687365906;10096.394216347042;5524.116141417354;5577.6932268724795;5578.721063946868;5581.134924086773;5596.552275818006;4489.506154323022;4626.259798432235;4628.074385122989;4673.392458980311;4874.122657921608;3860.4595356650093;3972.225416043844;3984.362501999666;3996.6403023728003;4010.0375909782024;1315.6776589735575;1340.4839136932155;1343.2276441046438;1352.573939209146;1352.594221733476;1126.6056880091903;1131.9377434241196;1147.6212849759727;1152.8040233160382;1180.4038960325151;8085.191480851985;8162.877556836652;8227.259546640711;8247.546384948766;8272.627731752085;520.1936997653622;527.7572316734345;532.8481382805882;533.3493138371181;534.6498043781329;6215.160953271341;6216.285127210338;6258.74965001404;6291.496680265568;6300;10329.9483502582;10704.946475267574;10809.567617295377;10836.891631083747;10838.566457341618;10442.903495133054;10462.163026957825;10588.841167382496;10654.840177397346;10675.62635307776;7144.9285507145305;8249.79375515605;8342.833143337099;8412.411131220879;8414.49513029208;7735.347112346825;7875.527468351917;7889.526628402315;7897.091834438883;7937.007874015748;9439.150476457151;9464.242860571276;9503.429794212369;9522.47626380528;9622.51887405641;9428.764280893032;9637.325387222827;9825.361351512129;9894.802103957736;9924.354916930377;6736.225334086643;7255.165655949633;7465.514741541782;7561.054868141482;7576.28025337592;8183.3862460316905;8277.793055173668;8287.337013038821;8295.626696798538;8295.626696798538;7269.7455589054125;7361.374283185989;7361.852762944818;7507.66215520292;7512.985746924095;7109.040279562193;7205.495615306878;7274.563526188445;7333.193348731528;7360.926390736024;6343.809685709436;7652.961735191288;7654.885176722242;7663.1570527243075;7694.384449243935;6065.8180254592435;6913.170419549686;6977.2673869243;6983.301669832976;6986.161660600557;6980.406665433292;7192.31672991065;7194.676239569128;7202.96398518004;7207.783766487014 07:47:35 INFO - PROCESS | 1673 | |4;prototype.html;318.1441921231886;321.4246498767207;325.5263591474405;327.7705606075747;330.1087064924704;6221.408966148214;6299.716512756925;6308.40070193332;6328.398802113803;6361.840953976153;4969;6233.2208473940755;6243.157173781538;6255.562110652245;6308.71610777515;4480.932786008212;4607.7004994675235;4622.560856718606;4623.630109591241;4683.555062269087;4616.192166370888;4641.187792136379;4685.20351540239;4695.812167513295;4718.905621887578;4643.257078867382;4649.20963436215;4664.650151238654;4684.765761711918;4685.976570117145;4656.674032817704;4664.55686709762;4664.766761661904;4675.2052151134385;4676.836310729125;3192.776505644606;3479.5998460176897;3863.5363756349416;3893.520462224365;4031.354983202703;6039.335673075958;6044.129038706623;6065.909011364789;6068.117644119052;6108.847278818021;5504.972475137599;5556.083246264361;5561.388247292794;5599.244102046253;5604.187392828057;6788.253292137861;6790.830229244259;6795.932040679629;6797.490188235902;6799.52403331767;3953.5651078381356;4364.625143079919;4535.727856328631;4544.318352247156;4546.613537849286;6911.723531058751;7169.641517924083;7194.640267986632;7204.387627051707;7213.314735100157;4617.422822147231;4656.8137274508645;4659.161350956861;4662.417197850269;4673.556012178838;4726.243800991825;4733.810647574059;4739.099571081552;4740.7392593407;4748.358971538798;5546.528545073633;5548;5549.973254947848;5556.91664625031;5560.388357280696;6783.694733736994;6788.083608712859;6811.4550835934;6834.829129271808;6846.383825455633;1238.2879844089684;1559.532140357888;1559.844015598431;1563.4840502634104;1568.7019466301367;1005.9647912323034;1015.3349556040805;1022.3303736052898;1034.4517405774952;1035.2080658296409;5980.13288073227;6170.969145154246;6230.56386052981;6236.438720515175;6244;6929.203141638776;6967.581945083311;7135.500514963903;7146.32109949554;7153.105861767279;6281.654509001957;6288.591241569284;6292.1505596743855;6292.244930608264;6318.71565779541;3085.9353523034515;3581.194231297937;3698.2973235085246;3742.3263812513464;3754.718396120302;6040.365761595057;7397.482176247719;7399.408047356199;7417.147028091731;7417.332440080419;7061.505694601328;7380.77857664271;7386.741464048732;7387.926120738832;7390.630468476555;6031.969840150771;7416.666250018762;7432.591207483641;7435.442341824385;7437.508434674336;7120.074390329224;7121.501494895308;7121.893171602326;7123.287671233043;7139;6820.317968203339;7027.7188912442925;7035.366816986496;7036.261192574911;7066.964665176642;6016.849578760391;7404.444666650131;7441.367483763941;7446.664900079401;7450.8882366763455;4433.977830110958;4523.819047238074;4531.048479819275;4531.637469002538;4534.2065138599955;7003.4747393944635;7018.859622807618;7021.05215795861;7030.121234845645;7044.189918159273;6810.216825065181;6816.693248803915;6826.078479405415;6826.658667066726;6828.624425656637;6555.737770489127;6761.763338283136;6786.423154031962;6802.965985170241;6803.795886123424;6602.60384376939;6620.907550254155;6639.3692599203;6645.401913827779;6650.900236496554;6780.660966951731;6780.966095169492;6783.152105986752;6790.083338749403;6805;6415.101885736094;6614.206295244601;6630.469562434897;6636.601803891782;6645.435138013323 07:47:35 INFO - PROCESS | 1673 | |5;yui.html;697.8360085379935;759.0966749568014;768.3622593247602;780.0600276666618;808.123186342818;15318.234088295583;15337.156456394894;15443.382264709413;15450.536483905473;15471.303791329388;14275.286235688225;14562.126272423635;14568.490102846403;14572;14579.125252484859;748.2293237964877;757.9242075792404;898.5641963647626;903.1510380242584;934.6448349627132;942.2603256443693;948.3029972969862;948.8529277961927;950.0214778777836;950.2540505703024;986.1223511075149;988.6786794291847;990.1385794358918;992.8014397120605;995.4624502768496;783.5337973905517;969;982.8280050991084;993.7614972406643;996.7707427291764;739.6967243430222;739.9075115610549;740.0822979505429;740.3780824107776;744.9106107267163;15001.249937503191;15072.472463463835;15073.849261507354;15105.697886042328;15110;10324;12433.191842530206;12501.187422817578;12566.748665026647;12836.16564923277;9961.40231586107;10056.94971525145;10084.495775211284;10123.493825308706;10373.84439233412;3165.192875816652;3440.7441283931435;3485.6688614581576;3530.452779819132;3564.108972756811;78626.60686696587;78930.6053469729;81627.59186204031;81961.77057344145;82010.58994705048;7014.894776578355;9429.104235097655;9468.857967130498;9630.855537166948;10121.1903047756;21929.451763706034;21997.890010549843;22021.449463763533;22034.779652203593;22146.667799983014;7327;7385.187629360766;7458.850822983619;7463.216362281991;7635.427342949301;4100.733452325649;4156.189543039079;4158.189153115113;4162.105147393265;4164.729292596032;3593.658602432765;3640.7087433005295;3652.397354436488;3655.5796083450214;3670.1191713988983;569.0610492687099;577.2784019975031;580.692233116449;583.1602492410915;598.8562744941182;578.1991941161522;599.7900734742805;614.8862460444832;617.0825051176363;626.9937300627026;8231.34149268057;8234.464759790595;8268.958655206685;8278.172182781795;8379.348768106971;586.2788769813069;589.2168367473237;604.6341963112342;611.1016805296207;615.187951903483;3306.272620023591;3878.84484620612;3881.463917628443;3938.822752976123;3947.6644485218503;72785;74556.5088698223;74870;74910;88305;70333.2966670337;70437;71090.9336359955;71421.57156856834;72378;63051.684741576;63383.68308158522;63891;64194.679026604565;64413;8435.95782021086;8446.493210407149;8477.703280385156;8531.445456045338;8668.089850565852;46040;46190.76904615456;46519.534804652874;47230.52769472399;47969.520304796504;59303.40696592979;62799;63666.76831859447;63812.08563743095;63981.36018639754;10719.678409647722;10803.351798892092;11028.448577570929;11110.888891111308;11313.094952403953;10391.324563903323;11671.766564668489;11889.405529723306;11982.880171198525;12180.33008184523;11285.266457680225;11346.773064538498;11416.942915285703;11439.828402573801;11760.82358764602;11601.883981160081;11639.301641901513;11657.300561966309;11891;11991.400429978641;11339.716507087389;11372.886271137182;11422.029127524254;11461.942690286494;11537.192396532499;9942.850857237292;10055;10085.267716653172;10094.697159085239;10187.439690817077;8902.643894244158;9348.36321779754;9701;9752.512374381111;9753.414795112316 07:47:35 INFO - PROCESS | 1673 | __end_tp_report 07:47:35 INFO - PROCESS | 1673 | __start_cc_report 07:47:35 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1581 07:47:35 INFO - PROCESS | 1673 | __end_cc_report 07:47:35 INFO - PROCESS | 1673 | __startTimestamp1457711255269__endTimestamp 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | ------- Summary: start ------- 07:47:35 INFO - PROCESS | 1673 | Number of tests: 6 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5644.72 Median:5866.21 stddev:647.85 (11.0%) stddev-sans-first:613.49 07:47:35 INFO - PROCESS | 1673 | Values: 2917.2 3406.1 3459.4 3482.8 3532.0 5461.6 5544.1 5590.0 5590.6 5607.2 5581.9 5614.1 5650.9 5703.6 5739.6 4996.6 5024.4 5029.4 5062.4 5179.9 5119.3 5128.5 5167.4 5169.5 5171.9 4979.0 4998.0 5085.5 5093.3 5122.6 5052.7 5065.5 5081.1 5084.4 5101.1 4982.0 5012.7 5027.2 5036.1 5051.3 5366.1 5463.8 5470.0 5548.9 5554.3 6145.9 6165.4 6170.3 6173.1 6176.4 6168.9 6221.6 6222.6 6232.4 6239.4 5547.3 5653.1 5658.7 5762.5 5768.3 6249.5 6253.6 6256.6 6260.8 6274.0 6011.3 6019.3 6053.7 6072.7 6099.3 6043.7 6121.4 6127.3 6177.9 6207.7 6111.8 6118.4 6119.2 6122.1 6127.7 6160.3 6168.5 6174.5 6184.1 6203.4 4326.6 4540.8 4734.2 4788.9 4865.2 4354.7 4355.2 4387.7 4391.6 4400.4 5579.4 5643.7 5654.2 5670.2 5675.6 6223.8 6232.1 6232.2 6239.7 6248.1 5431.6 5614.7 5628.6 5633.7 5637.7 5193.0 5234.3 5241.5 5266.3 5273.8 6209.8 6218.5 6222.0 6224.1 6232.2 6009.3 6184.5 6191.1 6224.9 6234.0 6177.7 6206.9 6218.1 6223.4 6252.7 6083.5 6100.4 6110.0 6112.3 6112.7 6001.0 6011.1 6157.9 6163.9 6169.8 5893.8 5911.1 5983.7 6043.5 6048.8 5951.2 5984.4 5996.1 6029.5 6031.9 5704.4 5839.9 5866.2 5866.8 5877.0 5893.9 5904.3 5923.4 5933.8 5935.7 5765.3 5767.0 5771.4 5784.6 5789.7 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:56043.38 Median:37346.00 stddev:105163.24 (281.6%) stddev-sans-first:105375.45 07:47:35 INFO - PROCESS | 1673 | Values: 462.4 570.8 573.9 640.5 642.9 37978.6 39093.0 39093.4 39140.0 39144.8 41762.8 42177.0 42317.8 42376.4 42413.6 9584.6 9752.0 9769.0 9774.0 9778.4 9629.0 9787.0 9791.4 9794.1 9800.8 9871.4 9945.4 9949.7 9952.1 9952.1 9802.2 9875.0 9875.6 9883.9 9889.8 8782.5 9449.4 9630.3 9785.2 9790.5 40881.4 41350.8 41443.0 41536.8 41563.0 3177.2 3253.4 3416.7 3466.7 3497.7 25152.9 26723.0 27238.9 28820.9 28925.3 2708.1 2796.1 2825.2 2879.6 2972.6 386965.0 391126.0 391223.0 391650.0 392164.0 65089.0 65535.0 69715.0 69831.7 69926.7 73658.6 73674.6 73777.6 73966.6 74263.0 15674.4 17377.9 17588.6 17605.4 17614.6 11786.9 11809.5 11873.6 13168.8 13448.5 16265.5 20708.7 21072.7 21180.0 21216.6 9325.1 9436.6 9558.6 9580.5 9619.5 938.8 998.3 1019.4 1119.3 1203.4 28508.9 28545.9 29421.6 29962.6 30051.4 1117.3 1162.4 1185.2 1202.4 1247.8 14892.7 15086.5 15150.2 15400.5 15481.8 439126.0 443281.0 445919.0 445926.0 445996.0 58499.7 59105.7 59128.0 59226.0 59229.0 1342.8 1414.2 1444.5 1445.5 1482.9 25968.9 28762.7 28918.6 29305.7 29864.3 47290.0 48053.8 48370.5 48386.0 48550.3 352146.0 355221.2 355380.0 355528.0 355648.0 23520.8 28826.1 32684.7 33312.7 33636.5 43968.3 44239.3 44511.1 44823.8 45604.8 34678.7 36615.8 37150.0 37542.0 37663.1 28082.6 29235.7 35603.5 36101.8 37006.4 35506.8 35988.1 36361.5 36836.6 36885.6 31149.4 31607.2 32113.8 32189.8 32568.2 24281.6 24476.8 24604.5 24652.0 24733.6 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:32175.63 Median:23950.38 stddev:88965.21 (371.5%) stddev-sans-first:89182.66 07:47:35 INFO - PROCESS | 1673 | Values: 336.9 355.3 360.4 362.5 363.8 20078.4 20619.5 21521.8 21969.2 22019.4 11674.1 12053.7 12065.4 12074.7 12092.5 5126.7 5161.3 5371.8 5392.4 5395.7 5279.2 5293.7 5305.5 5319.4 5338.9 5335.1 5337.3 5339.5 5550.4 5830.7 5711.2 5720.3 5757.7 5758.8 5761.9 4592.7 5453.6 5510.2 5523.6 5633.8 23494.3 23834.0 24066.8 25268.6 25292.6 2026.9 2054.4 2151.6 2262.8 2521.8 9740.4 9789.8 10115.2 12851.2 14275.3 1655.1 1722.1 1779.3 1811.8 1851.7 80258.0 106438.5 106627.0 107156.5 107232.5 11248.4 11287.5 11432.2 11435.2 11543.5 13786.9 13877.0 13887.0 13916.8 13929.2 8484.6 8661.4 8675.5 8767.6 8772.1 8836.2 8851.6 8886.9 8967.7 8973.2 4441.3 4523.0 4523.1 4563.6 4581.5 1858.8 1901.2 1906.8 1916.4 1930.9 871.3 911.4 978.6 984.6 1027.6 18929.0 19722.5 19766.8 19845.4 19918.4 783.9 785.6 956.4 956.6 1007.5 7493.3 10549.4 10592.7 10606.0 10790.6 496741.0 506421.0 507006.5 545586.0 596703.0 110706.0 112883.0 125884.0 131547.0 132286.0 854.8 969.7 1002.8 1007.5 1039.5 13546.2 16999.8 17586.0 17703.3 17870.6 54040.5 54128.0 54190.5 55011.7 55039.0 68497.0 73355.0 76398.0 79761.0 79798.6 7871.9 8030.5 8069.0 8152.5 8383.7 12076.8 13142.7 13238.9 13543.9 13577.5 11237.4 11516.3 11591.5 11623.2 11673.8 9247.4 11331.2 11454.5 11618.1 11683.7 11373.1 11405.5 11536.3 11720.8 11950.6 7853.5 8050.7 8063.9 8133.3 8367.8 10563.7 10976.8 11031.0 11400.1 11687.0 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:6002.70 Median:5440.54 stddev:3193.32 (58.7%) stddev-sans-first:3182.55 07:47:35 INFO - PROCESS | 1673 | Values: 1280.9 1404.4 1640.9 1843.3 1883.8 7289.7 7480.4 7964.6 8710.3 8758.0 8445.8 8699.2 8722.4 8730.5 8788.3 2180.1 2423.6 2472.8 2486.7 2505.6 2424.0 2424.4 2431.1 2431.5 2433.4 2434.7 2468.8 2491.8 2495.6 2501.1 2116.8 2424.1 2480.8 2484.1 2485.3 2105.7 2451.7 2498.3 2502.6 2503.4 8790.4 8867.4 8876.7 8882.5 8883.0 5357.0 5538.4 5549.8 5553.1 5595.6 3579.5 3682.8 3702.8 3736.6 3740.6 1030.4 1035.4 1039.3 1044.0 1057.1 11873.3 11877.5 11882.8 11903.7 11947.1 4225.8 4752.2 4910.9 5009.0 5016.3 10080.9 10088.3 10091.8 10094.6 10096.4 5524.1 5577.7 5578.7 5581.1 5596.6 4489.5 4626.3 4628.1 4673.4 4874.1 3860.5 3972.2 3984.4 3996.6 4010.0 1315.7 1340.5 1343.2 1352.6 1352.6 1126.6 1131.9 1147.6 1152.8 1180.4 8085.2 8162.9 8227.3 8247.5 8272.6 520.2 527.8 532.8 533.3 534.6 6215.2 6216.3 6258.7 6291.5 6300.0 10329.9 10704.9 10809.6 10836.9 10838.6 10442.9 10462.2 10588.8 10654.8 10675.6 7144.9 8249.8 8342.8 8412.4 8414.5 7735.3 7875.5 7889.5 7897.1 7937.0 9439.2 9464.2 9503.4 9522.5 9622.5 9428.8 9637.3 9825.4 9894.8 9924.4 6736.2 7255.2 7465.5 7561.1 7576.3 8183.4 8277.8 8287.3 8295.6 8295.6 7269.7 7361.4 7361.9 7507.7 7513.0 7109.0 7205.5 7274.6 7333.2 7360.9 6343.8 7653.0 7654.9 7663.2 7694.4 6065.8 6913.2 6977.3 6983.3 6986.2 6980.4 7192.3 7194.7 7203.0 7207.8 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5562.63 Median:6243.58 stddev:1788.42 (28.6%) stddev-sans-first:1749.59 07:47:35 INFO - PROCESS | 1673 | Values: 318.1 321.4 325.5 327.8 330.1 6221.4 6299.7 6308.4 6328.4 6361.8 4969.0 6233.2 6243.2 6255.6 6308.7 4480.9 4607.7 4622.6 4623.6 4683.6 4616.2 4641.2 4685.2 4695.8 4718.9 4643.3 4649.2 4664.7 4684.8 4686.0 4656.7 4664.6 4664.8 4675.2 4676.8 3192.8 3479.6 3863.5 3893.5 4031.4 6039.3 6044.1 6065.9 6068.1 6108.8 5505.0 5556.1 5561.4 5599.2 5604.2 6788.3 6790.8 6795.9 6797.5 6799.5 3953.6 4364.6 4535.7 4544.3 4546.6 6911.7 7169.6 7194.6 7204.4 7213.3 4617.4 4656.8 4659.2 4662.4 4673.6 4726.2 4733.8 4739.1 4740.7 4748.4 5546.5 5548.0 5550.0 5556.9 5560.4 6783.7 6788.1 6811.5 6834.8 6846.4 1238.3 1559.5 1559.8 1563.5 1568.7 1006.0 1015.3 1022.3 1034.5 1035.2 5980.1 6171.0 6230.6 6236.4 6244.0 6929.2 6967.6 7135.5 7146.3 7153.1 6281.7 6288.6 6292.2 6292.2 6318.7 3085.9 3581.2 3698.3 3742.3 3754.7 6040.4 7397.5 7399.4 7417.1 7417.3 7061.5 7380.8 7386.7 7387.9 7390.6 6032.0 7416.7 7432.6 7435.4 7437.5 7120.1 7121.5 7121.9 7123.3 7139.0 6820.3 7027.7 7035.4 7036.3 7067.0 6016.8 7404.4 7441.4 7446.7 7450.9 4434.0 4523.8 4531.0 4531.6 4534.2 7003.5 7018.9 7021.1 7030.1 7044.2 6810.2 6816.7 6826.1 6826.7 6828.6 6555.7 6761.8 6786.4 6803.0 6803.8 6602.6 6620.9 6639.4 6645.4 6650.9 6780.7 6781.0 6783.2 6790.1 6805.0 6415.1 6614.2 6630.5 6636.6 6645.4 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17323.42 Median:29946.31 stddev:23357.67 (78.0%) stddev-sans-first:23389.83 07:47:35 INFO - PROCESS | 1673 | Values: 697.8 759.1 768.4 780.1 808.1 15318.2 15337.2 15443.4 15450.5 15471.3 14275.3 14562.1 14568.5 14572.0 14579.1 748.2 757.9 898.6 903.2 934.6 942.3 948.3 948.9 950.0 950.3 986.1 988.7 990.1 992.8 995.5 783.5 969.0 982.8 993.8 996.8 739.7 739.9 740.1 740.4 744.9 15001.2 15072.5 15073.8 15105.7 15110.0 10324.0 12433.2 12501.2 12566.7 12836.2 9961.4 10056.9 10084.5 10123.5 10373.8 3165.2 3440.7 3485.7 3530.5 3564.1 78626.6 78930.6 81627.6 81961.8 82010.6 7014.9 9429.1 9468.9 9630.9 10121.2 21929.5 21997.9 22021.4 22034.8 22146.7 7327.0 7385.2 7458.9 7463.2 7635.4 4100.7 4156.2 4158.2 4162.1 4164.7 3593.7 3640.7 3652.4 3655.6 3670.1 569.1 577.3 580.7 583.2 598.9 578.2 599.8 614.9 617.1 627.0 8231.3 8234.5 8269.0 8278.2 8379.3 586.3 589.2 604.6 611.1 615.2 3306.3 3878.8 3881.5 3938.8 3947.7 72785.0 74556.5 74870.0 74910.0 88305.0 70333.3 70437.0 71090.9 71421.6 72378.0 63051.7 63383.7 63891.0 64194.7 64413.0 8436.0 8446.5 8477.7 8531.4 8668.1 46040.0 46190.8 46519.5 47230.5 47969.5 59303.4 62799.0 63666.8 63812.1 63981.4 10719.7 10803.4 11028.4 11110.9 11313.1 10391.3 11671.8 11889.4 11982.9 12180.3 11285.3 11346.8 11416.9 11439.8 11760.8 11601.9 11639.3 11657.3 11891.0 11991.4 11339.7 11372.9 11422.0 11461.9 11537.2 9942.9 10055.0 10085.3 10094.7 10187.4 8902.6 9348.4 9701.0 9752.5 9753.4 07:47:35 INFO - PROCESS | 1673 | -------- Summary: end -------- 07:47:35 INFO - PROCESS | 1673 | 07:47:35 INFO - TEST-INFO | 1673: exit 0 07:47:35 INFO - TEST-OK | dromaeo_css | took 1112937ms 07:47:35 INFO - TEST-START | kraken 07:47:35 INFO - operating with platform_type : mac_ 07:47:35 INFO - Initialising browser for kraken test... 07:47:35 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpiWrIS_/profile http://localhost:49270/getInfo.html) 07:47:37 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 07:47:37 INFO - PROCESS | 1682 | colorDepth:24 07:47:37 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 07:47:37 INFO - PROCESS | 1682 | __metrics 07:47:37 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:37 ERROR - PROCESS | 1682 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:47:38 INFO - TEST-INFO | 1682: exit 0 07:47:38 INFO - Browser initialized. 07:47:38 INFO - Running cycle 1/1 for kraken test... 07:47:38 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpiWrIS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:50 INFO - PROCESS | 1684 | RSS: Main: 243064832 07:47:50 INFO - PROCESS | 1684 | 07:47:53 INFO - PROCESS | 1684 | 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) 07:47:53 INFO - PROCESS | 1684 | RSS: Main: 288706560 07:47:53 INFO - PROCESS | 1684 | 07:47:56 INFO - PROCESS | 1684 | 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) 07:47:56 INFO - PROCESS | 1684 | RSS: Main: 300261376 07:47:56 INFO - PROCESS | 1684 | 07:48:00 INFO - PROCESS | 1684 | 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) 07:48:00 INFO - PROCESS | 1684 | RSS: Main: 286134272 07:48:00 INFO - PROCESS | 1684 | 07:48:02 INFO - PROCESS | 1684 | 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) 07:48:03 INFO - PROCESS | 1684 | RSS: Main: 288751616 07:48:03 INFO - PROCESS | 1684 | 07:48:05 INFO - PROCESS | 1684 | 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) 07:48:05 INFO - PROCESS | 1684 | RSS: Main: 288579584 07:48:05 INFO - PROCESS | 1684 | 07:48:08 INFO - PROCESS | 1684 | 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) 07:48:09 INFO - PROCESS | 1684 | RSS: Main: 289529856 07:48:09 INFO - PROCESS | 1684 | 07:48:12 INFO - PROCESS | 1684 | 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) 07:48:12 INFO - PROCESS | 1684 | RSS: Main: 290258944 07:48:12 INFO - PROCESS | 1684 | 07:48:15 INFO - PROCESS | 1684 | 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) 07:48:15 INFO - PROCESS | 1684 | RSS: Main: 291459072 07:48:15 INFO - PROCESS | 1684 | 07:48:17 INFO - PROCESS | 1684 | 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) 07:48:18 INFO - PROCESS | 1684 | RSS: Main: 325447680 07:48:18 INFO - PROCESS | 1684 | 07:48:19 INFO - PROCESS | 1684 | 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) 07:48:20 INFO - PROCESS | 1684 | RSS: Main: 324595712 07:48:20 INFO - PROCESS | 1684 | 07:48:22 INFO - PROCESS | 1684 | 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) 07:48:23 INFO - PROCESS | 1684 | RSS: Main: 330420224 07:48:23 INFO - PROCESS | 1684 | 07:48:25 INFO - PROCESS | 1684 | 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) 07:48:26 INFO - PROCESS | 1684 | RSS: Main: 331399168 07:48:26 INFO - PROCESS | 1684 | 07:48:28 INFO - PROCESS | 1684 | 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) 07:48:29 INFO - PROCESS | 1684 | RSS: Main: 331997184 07:48:29 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | 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) 07:48:31 INFO - PROCESS | 1684 | RSS: Main: 391696384 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | __start_tp_report 07:48:31 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 07:48:31 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 07:48:31 INFO - PROCESS | 1684 | |i|pagename|runs| 07:48:31 INFO - PROCESS | 1684 | |0;ai-astar;113;109;111;112;111;111;117;111;111;111 07:48:31 INFO - PROCESS | 1684 | |1;audio-beat-detection;155;119;141;180;149;148;157;150;171;118 07:48:31 INFO - PROCESS | 1684 | |2;audio-dft;183;185;183;184;187;187;186;180;182;186 07:48:31 INFO - PROCESS | 1684 | |3;audio-fft;74;75;85;78;57;57;61;78;76;56 07:48:31 INFO - PROCESS | 1684 | |4;audio-oscillator;92;93;127;76;82;81;114;76;80;111 07:48:31 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;86;90;131;91;86;90;87;89;86 07:48:31 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;94;95;95;94;94;94;97;94;94 07:48:31 INFO - PROCESS | 1684 | |7;imaging-desaturate;85;87;86;86;84;87;87;86;84;85 07:48:31 INFO - PROCESS | 1684 | |8;json-parse-financial;54;56;56;54;52;54;55;61;56;51 07:48:31 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;63;70;74;78;70;67;67;68;67;69 07:48:31 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;85;82;81;81;81;82;79;83;83;84 07:48:31 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;133;125;122;125;119;121;119;125;134;134 07:48:31 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;137;126;137;137;136;126;134;137;138;135 07:48:31 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;68;64;68;67;66;67;69;74;56;64 07:48:31 INFO - PROCESS | 1684 | __end_tp_report 07:48:31 INFO - PROCESS | 1684 | __start_cc_report 07:48:31 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1199 07:48:31 INFO - PROCESS | 1684 | __end_cc_report 07:48:31 INFO - PROCESS | 1684 | __startTimestamp1457711311288__endTimestamp 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | ------- Summary: start ------- 07:48:31 INFO - PROCESS | 1684 | Number of tests: 14 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:111.70 Median:111.00 stddev:2.11 (1.9%) stddev-sans-first:2.19 07:48:31 INFO - PROCESS | 1684 | Values: 113.0 109.0 111.0 112.0 111.0 111.0 117.0 111.0 111.0 111.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:152.50 stddev:19.64 (12.9%) stddev-sans-first:20.70 07:48:31 INFO - PROCESS | 1684 | Values: 155.0 119.0 141.0 180.0 149.0 148.0 157.0 150.0 171.0 118.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.50 stddev:2.31 (1.2%) stddev-sans-first:2.40 07:48:31 INFO - PROCESS | 1684 | Values: 183.0 185.0 183.0 184.0 187.0 187.0 186.0 180.0 182.0 186.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:69.70 Median:75.50 stddev:10.77 (14.3%) stddev-sans-first:11.31 07:48:31 INFO - PROCESS | 1684 | Values: 74.0 75.0 85.0 78.0 57.0 57.0 61.0 78.0 76.0 56.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:80.50 stddev:18.05 (22.4%) stddev-sans-first:19.14 07:48:31 INFO - PROCESS | 1684 | Values: 92.0 93.0 127.0 76.0 82.0 81.0 114.0 76.0 80.0 111.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:89.00 stddev:13.66 (15.3%) stddev-sans-first:14.43 07:48:31 INFO - PROCESS | 1684 | Values: 89.0 86.0 90.0 131.0 91.0 86.0 90.0 87.0 89.0 86.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 07:48:31 INFO - PROCESS | 1684 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 94.0 97.0 94.0 94.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 07:48:31 INFO - PROCESS | 1684 | Values: 85.0 87.0 86.0 86.0 84.0 87.0 87.0 86.0 84.0 85.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:2.73 (4.9%) stddev-sans-first:2.87 07:48:31 INFO - PROCESS | 1684 | Values: 54.0 56.0 56.0 54.0 52.0 54.0 55.0 61.0 56.0 51.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:4.16 (6.0%) stddev-sans-first:3.74 07:48:31 INFO - PROCESS | 1684 | Values: 63.0 70.0 74.0 78.0 70.0 67.0 67.0 68.0 67.0 69.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.50 stddev:1.73 (2.1%) stddev-sans-first:1.48 07:48:31 INFO - PROCESS | 1684 | Values: 85.0 82.0 81.0 81.0 81.0 82.0 79.0 83.0 83.0 84.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:125.00 stddev:5.95 (4.8%) stddev-sans-first:5.69 07:48:31 INFO - PROCESS | 1684 | Values: 133.0 125.0 122.0 125.0 119.0 121.0 119.0 125.0 134.0 134.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.30 Median:137.00 stddev:4.52 (3.3%) stddev-sans-first:4.69 07:48:31 INFO - PROCESS | 1684 | Values: 137.0 126.0 137.0 137.0 136.0 126.0 134.0 137.0 138.0 135.0 07:48:31 INFO - PROCESS | 1684 | 07:48:31 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.50 stddev:4.60 (6.8%) stddev-sans-first:4.83 07:48:31 INFO - PROCESS | 1684 | Values: 68.0 64.0 68.0 67.0 66.0 67.0 69.0 74.0 56.0 64.0 07:48:31 INFO - PROCESS | 1684 | -------- Summary: end -------- 07:48:31 INFO - PROCESS | 1684 | 07:48:32 INFO - TEST-INFO | 1684: exit 0 07:48:32 INFO - TEST-OK | kraken | took 56305ms 07:48:32 INFO - SUITE-END | took 1169s 07:48:32 INFO - Completed test suite (00:19:29) 07:48:32 INFO - javascript benchmark 07:48:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2917.2415172055257, 3406.1314364836967, 3459.4464885618304, 3482.791032538048, 3532.046347486179, 5461.617686761928, 5544.085225937715, 5590.0, 5590.608657393979, 5607.186957891108, 5581.8604534886645, 5614.073677843161, 5650.886982260352, 5703.57223208259, 5739.598228124033, 4996.5503104720565, 5024.371953505812, 5029.421616514092, 5062.417821950467, 5179.948200517984, 5119.308893299394, 5128.53843154116, 5167.354080739908, 5169.508896654812, 5171.87070323243, 4978.999999999982, 4997.950020499785, 5085.542301192873, 5093.312402825608, 5122.615803814729, 5052.69683818972, 5065.518775716301, 5081.110805609041, 5084.389873215201, 5101.107306221434, 4982.0, 5012.749362531858, 5027.170516864713, 5036.093503169464, 5051.343325367716, 5366.114591092465, 5463.836084917459, 5470.0, 5548.944510554924, 5554.2779438673115, 6145.907811382833, 6165.383461653843, 6170.2904166021035, 6173.074038894157, 6176.351483094255, 6168.87662246757, 6221.564490485668, 6222.626642401425, 6232.376762323776, 6239.37606239377, 5547.3343198816, 5653.067243904751, 5658.745356458928, 5762.481376676119, 5768.2501274834, 6249.500039996789, 6253.624782513064, 6256.562040657111, 6260.780872669435, 6274.0, 6011.308699499614, 6019.307779605401, 6053.727582258809, 6072.666003369769, 6099.329073801879, 6043.667598282049, 6121.422488707842, 6127.311699317065, 6177.938220617826, 6207.689615519206, 6111.755529778759, 6118.388161183846, 6119.197913140505, 6122.1338301444075, 6127.6782420562195, 6160.260768707694, 6168.506519478431, 6174.536909731788, 6184.134221209034, 6203.410675985774, 4326.610605045561, 4540.751293394277, 4734.19518681818, 4788.928166077511, 4865.172920603506, 4354.695171337976, 4355.1725172217175, 4387.692861499664, 4391.604755572014, 4400.427944367276, 5579.358373786985, 5643.661380317112, 5654.208410822488, 5670.234518340054, 5675.631083979611, 6223.844403889939, 6232.065190221412, 6232.158658581124, 6239.719212635442, 6248.094026366151, 5431.646942948696, 5614.747336369873, 5628.60599758013, 5633.690147041952, 5637.7181140942785, 5193.0, 5234.26720259164, 5241.528262456397, 5266.289050978069, 5273.815416460406, 6209.782657606962, 6218.533609979179, 6222.0, 6224.097505861625, 6232.220972378453, 6009.308929472992, 6184.5052395809125, 6191.071339299141, 6224.875502490016, 6233.968830156002, 6177.660228687286, 6206.906896396467, 6218.06728990655, 6223.37766223374, 6252.718627661675, 6083.452489275986, 6100.389961003864, 6110.0, 6112.346079876185, 6112.74665817949, 6001.0, 6011.128386384037, 6157.907631385622, 6163.876722465436, 6169.753209871555, 5893.793717219876, 5911.113333000085, 5983.730732116978, 6043.486303664238, 6048.758049678139, 5951.196588460502, 5984.371640977634, 5996.130561068708, 6029.51763858899, 6031.879362412639, 5704.429557044428, 5839.941600583939, 5866.208061911758, 5866.794662186803, 5877.0, 5893.852653683521, 5904.3210030847, 5923.4076592340425, 5933.762649493972, 5935.7032148391545, 5765.250517432707, 5767.048437007847, 5771.394003629726, 5784.566157538117, 5789.710514474175], "unit": "score", "name": "dojo.html", "value": 5601.970460050956}, {"lowerIsBetter": false, "replicates": [462.36194052207946, 570.7842295909712, 573.9496721000569, 640.4876099120704, 642.8907085795415, 37978.620213797854, 39093.02267443315, 39093.41359879597, 39140.0, 39144.804275978655, 41762.7911860441, 42177.0, 42317.788411057976, 42376.36435453471, 42413.57586424142, 9584.56869440875, 9751.951240243789, 9768.974257702945, 9773.951130244339, 9778.364406313567, 9628.951855240713, 9786.951065244664, 9791.412515249072, 9794.118529332358, 9800.803983920317, 9871.407715537054, 9945.408734602464, 9949.651762188325, 9952.054554817281, 9952.054554817318, 9802.2158227342, 9874.9506252469, 9875.555599998017, 9883.851742223873, 9889.75275618108, 8782.516961567175, 9449.43303401798, 9630.3258771886, 9785.168260697848, 9790.461524616143, 40881.386779198336, 41350.79324603388, 41443.0, 41536.792316038525, 41563.0, 3177.205698575356, 3253.3655937092276, 3416.7095796857298, 3466.6706662866986, 3497.7376696747847, 25152.868120934603, 26723.0, 27238.863805680845, 28820.855895720386, 28925.276868078465, 2708.065717327519, 2796.1331987083868, 2825.2371859597997, 2879.5536691812804, 2972.613560237177, 386965.0, 391125.99999999715, 391222.99999999715, 391650.0, 392164.0, 65089.023664645065, 65535.0, 69714.9542756849, 69831.65084174546, 69926.65036674784, 73658.63170684113, 73674.6316268426, 73777.6311118441, 73966.63016684882, 74263.0, 15674.373025079098, 17377.91311043462, 17588.592912566965, 17605.38381156679, 17614.647707045788, 11786.88213117875, 11809.52761889532, 11873.643790686294, 13168.802467962989, 13448.529301474597, 16265.496598866113, 20708.689369659467, 21072.683909741365, 21180.0, 21216.575668486545, 9325.067493250757, 9436.575354109082, 9558.56986435612, 9580.473073980998, 9619.470929098967, 938.7653086728318, 998.3111652959435, 1019.3832731197518, 1119.2556949628406, 1203.4163430736087, 28508.859645614357, 28545.857270713514, 29421.55867661987, 29962.55056174159, 30051.398972020874, 1117.2626066795876, 1162.4304090995352, 1185.1940680337452, 1202.4468744377684, 1247.8190662354089, 14892.70214595702, 15086.54740357791, 15150.16674082936, 15400.46098386551, 15481.767773483407, 439126.0, 443281.0, 445919.0, 445926.0, 445996.0, 58499.70750146222, 59105.704471477366, 59128.0, 59226.0, 59229.0, 1342.8455727591256, 1414.1868425655289, 1444.5377479206552, 1445.5302026841318, 1482.9110253384831, 25968.8701556491, 28762.712372876, 28918.566221506273, 29305.706942930297, 29864.25339366446, 47290.0, 48053.75973120112, 48370.5162948366, 48386.0, 48550.271745923135, 352146.0, 355221.22389387887, 355380.0, 355528.0, 355648.0, 23520.764792352544, 28826.135215943556, 32684.673153268162, 33312.666873330956, 33636.49545256872, 43968.34047489226, 44239.336409953234, 44511.10977780491, 44823.77588112038, 45604.771976139906, 34678.65321346754, 36615.816920915226, 37150.0, 37542.0, 37663.0816516642, 28082.57876131819, 29235.7076429233, 35603.465948010286, 36101.81949090238, 37006.44490332701, 35506.822465887504, 35988.10029749277, 36361.45457818082, 36836.63163368332, 36885.631143689294, 31149.377012459172, 31607.19103818358, 32113.8394308027, 32189.839050804596, 32568.223029237142, 24281.63577546303, 24476.758092807795, 24604.507909841344, 24652.0, 24733.62899556544], "unit": "score", "name": "ext.html", "value": 19623.775716804543}, {"lowerIsBetter": false, "replicates": [336.9285671564425, 355.28410253339524, 360.4485137739258, 362.45450596851737, 363.77082438064014, 20078.397648070546, 20619.484512887186, 21521.784782152194, 21969.23107691231, 22019.449513762163, 11674.066074714025, 12053.698657533567, 12065.3967301635, 12074.698132546691, 12092.455839487244, 5126.718030508339, 5161.27742116104, 5371.785128594852, 5392.352917649888, 5395.7032363220005, 5279.155335146377, 5293.708846013467, 5305.495977882095, 5319.414864364917, 5338.866528336784, 5335.119705248649, 5337.332833395825, 5339.519443250107, 5550.417206193352, 5830.737616807254, 5711.171880077386, 5720.256366672347, 5757.65454072757, 5758.798442054529, 5761.88476230473, 4592.678512504126, 5453.590980676426, 5510.173473978895, 5523.558115350762, 5633.8309850704545, 23494.29517114489, 23834.0, 24066.759332406626, 25268.620970685453, 25292.620610690854, 2026.878387296767, 2054.4488317548953, 2151.612709712251, 2262.827740003274, 2521.848689078661, 9740.415575065519, 9789.804203915883, 10115.190784737204, 12851.228926264454, 14275.286235688174, 1655.0979716054778, 1722.0872937343229, 1779.288284686123, 1811.7644706188112, 1851.6666999940005, 80257.99999999942, 106438.46780766046, 106627.0, 107156.4642176792, 107232.46383768109, 11248.381339026431, 11287.54849806015, 11432.199746017699, 11435.199536032564, 11543.480543375568, 13786.862131378759, 13876.959228057734, 13887.0, 13916.791248131287, 13929.23389213603, 8484.618192181366, 8661.393702440895, 8675.479471231747, 8767.605457754416, 8772.105205282242, 8836.204741573289, 8851.64593416269, 8886.911130888608, 8967.668406214301, 8973.19241268276, 4441.289393696993, 4523.0, 4523.050159466549, 4563.612092972135, 4581.496035436099, 1858.7862395824384, 1901.1729897494633, 1906.8474522038205, 1916.3963351544219, 1930.893800840939, 871.333429926107, 911.4030310146865, 978.5792109393029, 984.5667906121427, 1027.6249169053392, 18929.0, 19722.50693732668, 19766.802331976785, 19845.404637860887, 19918.402447926586, 783.9098503672037, 785.6229010075195, 956.4404823178519, 956.5934477847027, 1007.5466040281902, 7493.3256006958545, 10549.367037977747, 10592.682219533426, 10606.0, 10790.622328218475, 496741.0, 506421.0, 507006.46496767283, 545586.0, 596703.0, 110706.0, 112883.0, 125884.0, 131547.0, 132286.0, 854.7777577829809, 969.7236287657984, 1002.756581838515, 1007.4761124215366, 1039.5374058544026, 13546.187228766306, 16999.81001329895, 17586.03276819787, 17703.291868325123, 17870.642587147926, 54040.45959540354, 54128.0, 54190.458095418544, 55011.72494137504, 55039.0, 68497.0, 73355.0, 76398.0, 79761.0, 79798.60100699459, 7871.921280787119, 8030.478018928751, 8068.99137607799, 8152.470089444168, 8383.664653413794, 12076.75846483083, 13142.671433213864, 13238.867611323763, 13543.86456135426, 13577.456901723821, 11237.38194399316, 11516.251443656136, 11591.478383472933, 11623.244489108181, 11673.766524669629, 9247.393516528693, 11331.206815522833, 11454.541818327174, 11618.0705543558, 11683.707907302385, 11373.090152787923, 11405.486753095965, 11536.25014374063, 11720.824187637021, 11950.581729639422, 7853.489523180975, 8050.677972881019, 8063.8790418144945, 8133.308668763221, 8367.790805229917, 10563.683089507327, 10976.835347469634, 11031.007209351197, 11400.087992960378, 11687.0], "unit": "score", "name": "jquery.html", "value": 9209.543365852423}, {"lowerIsBetter": false, "replicates": [1280.8591054983945, 1404.382071888369, 1640.8523232909035, 1843.2903332217102, 1883.7645294338208, 7289.744858929932, 7480.364169045624, 7964.641591128398, 8710.303175745941, 8757.956210218948, 8445.831083378343, 8699.173578510046, 8722.389432739696, 8730.476171429718, 8788.2969362451, 2180.1170525937023, 2423.5758742220128, 2472.7774500295013, 2486.7140278867982, 2505.5991041433376, 2424.018272599591, 2424.3939015246187, 2431.088341871798, 2431.525852458771, 2433.4403087289934, 2434.6956630421196, 2468.8024958003407, 2491.813114016447, 2495.6381324707904, 2501.0746023971155, 2116.75657299411, 2424.090965887792, 2480.7519248075137, 2484.142970675114, 2485.3413845331, 2105.673620588796, 2451.681281433402, 2498.3254521279155, 2502.5995840665405, 2503.4116982509095, 8790.384673072887, 8867.423617464845, 8876.733697989072, 8882.467051976902, 8882.955585222096, 5356.973215133899, 5538.446155384469, 5549.833504994856, 5553.139263414137, 5595.580331475115, 3579.480975258599, 3682.797446140461, 3702.796591107901, 3736.5889752127246, 3740.6259374062647, 1030.3560274828233, 1035.377898013785, 1039.3452125161175, 1043.9582416703322, 1057.0750593230923, 11873.346965916871, 11877.524899004116, 11882.821757673642, 11903.702407439796, 11947.103967202494, 4225.788710564521, 4752.1683705351425, 4910.877228069256, 5009.0, 5016.297718319438, 10080.949595252123, 10088.293819432569, 10091.848622270672, 10094.646687365906, 10096.394216347042, 5524.116141417354, 5577.6932268724795, 5578.721063946868, 5581.134924086773, 5596.552275818006, 4489.506154323022, 4626.259798432235, 4628.074385122989, 4673.392458980311, 4874.122657921608, 3860.4595356650093, 3972.225416043844, 3984.362501999666, 3996.6403023728003, 4010.0375909782024, 1315.6776589735575, 1340.4839136932155, 1343.2276441046438, 1352.573939209146, 1352.594221733476, 1126.6056880091903, 1131.9377434241196, 1147.6212849759727, 1152.8040233160382, 1180.4038960325151, 8085.191480851985, 8162.877556836652, 8227.259546640711, 8247.546384948766, 8272.627731752085, 520.1936997653622, 527.7572316734345, 532.8481382805882, 533.3493138371181, 534.6498043781329, 6215.160953271341, 6216.285127210338, 6258.74965001404, 6291.496680265568, 6300.0, 10329.9483502582, 10704.946475267574, 10809.567617295377, 10836.891631083747, 10838.566457341618, 10442.903495133054, 10462.163026957825, 10588.841167382496, 10654.840177397346, 10675.62635307776, 7144.9285507145305, 8249.79375515605, 8342.833143337099, 8412.411131220879, 8414.49513029208, 7735.347112346825, 7875.527468351917, 7889.526628402315, 7897.091834438883, 7937.007874015748, 9439.150476457151, 9464.242860571276, 9503.429794212369, 9522.47626380528, 9622.51887405641, 9428.764280893032, 9637.325387222827, 9825.361351512129, 9894.802103957736, 9924.354916930377, 6736.225334086643, 7255.165655949633, 7465.514741541782, 7561.054868141482, 7576.28025337592, 8183.3862460316905, 8277.793055173668, 8287.337013038821, 8295.626696798538, 8295.626696798538, 7269.7455589054125, 7361.374283185989, 7361.852762944818, 7507.66215520292, 7512.985746924095, 7109.040279562193, 7205.495615306878, 7274.563526188445, 7333.193348731528, 7360.926390736024, 6343.809685709436, 7652.961735191288, 7654.885176722242, 7663.1570527243075, 7694.384449243935, 6065.8180254592435, 6913.170419549686, 6977.2673869243, 6983.301669832976, 6986.161660600557, 6980.406665433292, 7192.31672991065, 7194.676239569128, 7202.96398518004, 7207.783766487014], "unit": "score", "name": "mootools.html", "value": 4803.494628437205}, {"lowerIsBetter": false, "replicates": [318.1441921231886, 321.4246498767207, 325.5263591474405, 327.7705606075747, 330.1087064924704, 6221.408966148214, 6299.716512756925, 6308.40070193332, 6328.398802113803, 6361.840953976153, 4969.0, 6233.2208473940755, 6243.157173781538, 6255.562110652245, 6308.71610777515, 4480.932786008212, 4607.7004994675235, 4622.560856718606, 4623.630109591241, 4683.555062269087, 4616.192166370888, 4641.187792136379, 4685.20351540239, 4695.812167513295, 4718.905621887578, 4643.257078867382, 4649.20963436215, 4664.650151238654, 4684.765761711918, 4685.976570117145, 4656.674032817704, 4664.55686709762, 4664.766761661904, 4675.2052151134385, 4676.836310729125, 3192.776505644606, 3479.5998460176897, 3863.5363756349416, 3893.520462224365, 4031.354983202703, 6039.335673075958, 6044.129038706623, 6065.909011364789, 6068.117644119052, 6108.847278818021, 5504.972475137599, 5556.083246264361, 5561.388247292794, 5599.244102046253, 5604.187392828057, 6788.253292137861, 6790.830229244259, 6795.932040679629, 6797.490188235902, 6799.52403331767, 3953.5651078381356, 4364.625143079919, 4535.727856328631, 4544.318352247156, 4546.613537849286, 6911.723531058751, 7169.641517924083, 7194.640267986632, 7204.387627051707, 7213.314735100157, 4617.422822147231, 4656.8137274508645, 4659.161350956861, 4662.417197850269, 4673.556012178838, 4726.243800991825, 4733.810647574059, 4739.099571081552, 4740.7392593407, 4748.358971538798, 5546.528545073633, 5548.0, 5549.973254947848, 5556.91664625031, 5560.388357280696, 6783.694733736994, 6788.083608712859, 6811.4550835934, 6834.829129271808, 6846.383825455633, 1238.2879844089684, 1559.532140357888, 1559.844015598431, 1563.4840502634104, 1568.7019466301367, 1005.9647912323034, 1015.3349556040805, 1022.3303736052898, 1034.4517405774952, 1035.2080658296409, 5980.13288073227, 6170.969145154246, 6230.56386052981, 6236.438720515175, 6244.0, 6929.203141638776, 6967.581945083311, 7135.500514963903, 7146.32109949554, 7153.105861767279, 6281.654509001957, 6288.591241569284, 6292.1505596743855, 6292.244930608264, 6318.71565779541, 3085.9353523034515, 3581.194231297937, 3698.2973235085246, 3742.3263812513464, 3754.718396120302, 6040.365761595057, 7397.482176247719, 7399.408047356199, 7417.147028091731, 7417.332440080419, 7061.505694601328, 7380.77857664271, 7386.741464048732, 7387.926120738832, 7390.630468476555, 6031.969840150771, 7416.666250018762, 7432.591207483641, 7435.442341824385, 7437.508434674336, 7120.074390329224, 7121.501494895308, 7121.893171602326, 7123.287671233043, 7139.0, 6820.317968203339, 7027.7188912442925, 7035.366816986496, 7036.261192574911, 7066.964665176642, 6016.849578760391, 7404.444666650131, 7441.367483763941, 7446.664900079401, 7450.8882366763455, 4433.977830110958, 4523.819047238074, 4531.048479819275, 4531.637469002538, 4534.2065138599955, 7003.4747393944635, 7018.859622807618, 7021.05215795861, 7030.121234845645, 7044.189918159273, 6810.216825065181, 6816.693248803915, 6826.078479405415, 6826.658667066726, 6828.624425656637, 6555.737770489127, 6761.763338283136, 6786.423154031962, 6802.965985170241, 6803.795886123424, 6602.60384376939, 6620.907550254155, 6639.3692599203, 6645.401913827779, 6650.900236496554, 6780.660966951731, 6780.966095169492, 6783.152105986752, 6790.083338749403, 6805.0, 6415.101885736094, 6614.206295244601, 6630.469562434897, 6636.601803891782, 6645.435138013323], "unit": "score", "name": "prototype.html", "value": 4961.825237433433}, {"lowerIsBetter": false, "replicates": [697.8360085379935, 759.0966749568014, 768.3622593247602, 780.0600276666618, 808.123186342818, 15318.234088295583, 15337.156456394894, 15443.382264709413, 15450.536483905473, 15471.303791329388, 14275.286235688225, 14562.126272423635, 14568.490102846403, 14572.0, 14579.125252484859, 748.2293237964877, 757.9242075792404, 898.5641963647626, 903.1510380242584, 934.6448349627132, 942.2603256443693, 948.3029972969862, 948.8529277961927, 950.0214778777836, 950.2540505703024, 986.1223511075149, 988.6786794291847, 990.1385794358918, 992.8014397120605, 995.4624502768496, 783.5337973905517, 969.0, 982.8280050991084, 993.7614972406643, 996.7707427291764, 739.6967243430222, 739.9075115610549, 740.0822979505429, 740.3780824107776, 744.9106107267163, 15001.249937503191, 15072.472463463835, 15073.849261507354, 15105.697886042328, 15110.0, 10324.0, 12433.191842530206, 12501.187422817578, 12566.748665026647, 12836.16564923277, 9961.40231586107, 10056.94971525145, 10084.495775211284, 10123.493825308706, 10373.84439233412, 3165.192875816652, 3440.7441283931435, 3485.6688614581576, 3530.452779819132, 3564.108972756811, 78626.60686696587, 78930.6053469729, 81627.59186204031, 81961.77057344145, 82010.58994705048, 7014.894776578355, 9429.104235097655, 9468.857967130498, 9630.855537166948, 10121.1903047756, 21929.451763706034, 21997.890010549843, 22021.449463763533, 22034.779652203593, 22146.667799983014, 7327.0, 7385.187629360766, 7458.850822983619, 7463.216362281991, 7635.427342949301, 4100.733452325649, 4156.189543039079, 4158.189153115113, 4162.105147393265, 4164.729292596032, 3593.658602432765, 3640.7087433005295, 3652.397354436488, 3655.5796083450214, 3670.1191713988983, 569.0610492687099, 577.2784019975031, 580.692233116449, 583.1602492410915, 598.8562744941182, 578.1991941161522, 599.7900734742805, 614.8862460444832, 617.0825051176363, 626.9937300627026, 8231.34149268057, 8234.464759790595, 8268.958655206685, 8278.172182781795, 8379.348768106971, 586.2788769813069, 589.2168367473237, 604.6341963112342, 611.1016805296207, 615.187951903483, 3306.272620023591, 3878.84484620612, 3881.463917628443, 3938.822752976123, 3947.6644485218503, 72785.0, 74556.5088698223, 74870.0, 74910.0, 88305.0, 70333.2966670337, 70437.0, 71090.9336359955, 71421.57156856834, 72378.0, 63051.684741576, 63383.68308158522, 63891.0, 64194.679026604565, 64413.0, 8435.95782021086, 8446.493210407149, 8477.703280385156, 8531.445456045338, 8668.089850565852, 46040.0, 46190.76904615456, 46519.534804652874, 47230.52769472399, 47969.520304796504, 59303.40696592979, 62799.0, 63666.76831859447, 63812.08563743095, 63981.36018639754, 10719.678409647722, 10803.351798892092, 11028.448577570929, 11110.888891111308, 11313.094952403953, 10391.324563903323, 11671.766564668489, 11889.405529723306, 11982.880171198525, 12180.33008184523, 11285.266457680225, 11346.773064538498, 11416.942915285703, 11439.828402573801, 11760.82358764602, 11601.883981160081, 11639.301641901513, 11657.300561966309, 11891.0, 11991.400429978641, 11339.716507087389, 11372.886271137182, 11422.029127524254, 11461.942690286494, 11537.192396532499, 9942.850857237292, 10055.0, 10085.267716653172, 10094.697159085239, 10187.439690817077, 8902.643894244158, 9348.36321779754, 9701.0, 9752.512374381111, 9753.414795112316], "unit": "score", "name": "yui.html", "value": 6850.947189508294}], "name": "dromaeo_css", "value": 7408.402109176898}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 112.0, 111.0, 111.0, 117.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 141.0, 180.0, 149.0, 148.0, 157.0, 150.0, 171.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [183.0, 185.0, 183.0, 184.0, 187.0, 187.0, 186.0, 180.0, 182.0, 186.0], "unit": "score", "name": "audio-dft", "value": 184.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 85.0, 78.0, 57.0, 57.0, 61.0, 78.0, 76.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 127.0, 76.0, 82.0, 81.0, 114.0, 76.0, 80.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 93.2}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 90.0, 131.0, 91.0, 86.0, 90.0, 87.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 97.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 94.5}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 86.0, 86.0, 84.0, 87.0, 87.0, 86.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.7}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 56.0, 54.0, 52.0, 54.0, 55.0, 61.0, 56.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [63.0, 70.0, 74.0, 78.0, 70.0, 67.0, 67.0, 68.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 81.0, 81.0, 81.0, 82.0, 79.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.1}, {"lowerIsBetter": true, "replicates": [133.0, 125.0, 122.0, 125.0, 119.0, 121.0, 119.0, 125.0, 134.0, 134.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.7}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 137.0, 137.0, 136.0, 126.0, 134.0, 137.0, 138.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.3}, {"lowerIsBetter": true, "replicates": [68.0, 64.0, 68.0, 67.0, 66.0, 67.0, 69.0, 74.0, 56.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1413.0}]} 07:48:32 INFO - Return code: 0 07:48:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:32 ERROR - # TBPL SUCCESS # 07:48:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:32 INFO - 2016-03-11 07:48:32.588 screenresolution[1688:9668] starting screenresolution argv=screenresolution get 07:48:32 INFO - 2016-03-11 07:48:32.591 screenresolution[1688:9668] Display 0: 1600x1200x32@60 07:48:32 INFO - 2016-03-11 07:48:32.597 screenresolution[1689:9671] starting screenresolution argv=screenresolution list 07:48:32 INFO - Available Modes on Display 0 07:48:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:32 INFO - Intel Iris: 07:48:32 INFO - Chipset Model: Intel Iris 07:48:32 INFO - Type: GPU 07:48:32 INFO - Bus: Built-In 07:48:32 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:32 INFO - Vendor: Intel (0x8086) 07:48:32 INFO - Device ID: 0x0a2e 07:48:32 INFO - Revision ID: 0x0009 07:48:32 INFO - Displays: 07:48:32 INFO - Display: 07:48:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:32 INFO - Display Serial Number: 1600x1200 60 07:48:32 INFO - Main Display: Yes 07:48:32 INFO - Mirror: Off 07:48:32 INFO - Online: Yes 07:48:32 INFO - Rotation: Supported 07:48:32 INFO - Return code: 0 07:48:32 INFO - Running post-action listener: _resource_record_post_action 07:48:32 INFO - Running post-run listener: _resource_record_post_run 07:48:33 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39626240; Write bytes: 701140992; Read time: 447; Write time: 2402 07:48:33 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399673856; Write bytes: 393180672; Read time: 30546; Write time: 665 07:48:33 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33497088; Write bytes: 296958464; Read time: 365; Write time: 1703 07:48:33 INFO - Running post-run listener: _upload_blobber_files 07:48:33 INFO - Blob upload gear active. 07:48:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:48:34 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:34 INFO - (blobuploader) - INFO - Done attempting. 07:48:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:35 INFO - (blobuploader) - INFO - Done attempting. 07:48:35 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:36 INFO - Return code: 0 07:48:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0c3a109c2982f36a3f73121e13a60c807f91509078085997a074122496bb964466c1ad27c6b039fd95419b31286f34ef2ac7fc7b23f96cf8334eb0fddb0b718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14e04112ae0632ef3993d3011e0d4fed2478e680384907b81bbb6dbf362d5b64d43eec89fa624483280ad398c0f5c4b3b57d40a5042a6c57be3992ea9e657cc1"} 07:48:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:36 INFO - Contents: 07:48:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0c3a109c2982f36a3f73121e13a60c807f91509078085997a074122496bb964466c1ad27c6b039fd95419b31286f34ef2ac7fc7b23f96cf8334eb0fddb0b718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14e04112ae0632ef3993d3011e0d4fed2478e680384907b81bbb6dbf362d5b64d43eec89fa624483280ad398c0f5c4b3b57d40a5042a6c57be3992ea9e657cc1"} 07:48:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:36 INFO - Copying logs to upload dir... 07:48:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.024123 ========= master_lag: 7.42 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-11 07:48:43.449159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-11 07:48:43.457080) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/a0c3a109c2982f36a3f73121e13a60c807f91509078085997a074122496bb964466c1ad27c6b039fd95419b31286f34ef2ac7fc7b23f96cf8334eb0fddb0b718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14e04112ae0632ef3993d3011e0d4fed2478e680384907b81bbb6dbf362d5b64d43eec89fa624483280ad398c0f5c4b3b57d40a5042a6c57be3992ea9e657cc1"} build_url:https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/GcblEMjvQla9NqG9Li6oeA/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/a0c3a109c2982f36a3f73121e13a60c807f91509078085997a074122496bb964466c1ad27c6b039fd95419b31286f34ef2ac7fc7b23f96cf8334eb0fddb0b718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/14e04112ae0632ef3993d3011e0d4fed2478e680384907b81bbb6dbf362d5b64d43eec89fa624483280ad398c0f5c4b3b57d40a5042a6c57be3992ea9e657cc1"}' ========= master_lag: 5.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-11 07:48:48.831425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:48.831842) ========= 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.j01Hsx6HDy/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.MtfkvvsP19/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005278 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 07:48:48.959202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:48:48.959519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 07:48:49.008013) ========= ========= Total master_lag: 13.07 =========