builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0158 starttime: 1459993407.42 results: success (0) buildid: 20160406164046 builduid: 987ac747e62a44aa8b92277fe2daee8a revision: 572875411dbaa092bf066a9ce561da6a2fc1c293 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:27.422714) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:27.423143) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-04-06 18:43:27.423431) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005757 basedir: '/builds/slave/test' ========= master_lag: 2.84 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-04-06 18:43:30.272805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-06 18:43:30.273112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-04-06 18:43:32.540807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:32.541107) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005285 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:32.615240) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:32.615557) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:32.615911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:32.616185) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-06 18:43:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.41M=0.001s 2016-04-06 18:43:32 (8.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190748 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:33.224629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:33.224999) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.019855 ========= master_lag: 0.85 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:34.099150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:34.099469) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 572875411dbaa092bf066a9ce561da6a2fc1c293 --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 572875411dbaa092bf066a9ce561da6a2fc1c293 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-06 18:43:34,205 truncating revision to first 12 chars 2016-04-06 18:43:34,205 Setting DEBUG logging. 2016-04-06 18:43:34,205 attempt 1/10 2016-04-06 18:43:34,205 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/572875411dba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 18:43:34,795 unpacking tar archive at: fx-team-572875411dba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.839090 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:34.988831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:34.989152) ========= echo 572875411dbaa092bf066a9ce561da6a2fc1c293 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'572875411dbaa092bf066a9ce561da6a2fc1c293'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 572875411dbaa092bf066a9ce561da6a2fc1c293 program finished with exit code 0 elapsedTime=0.004756 script_repo_revision: '572875411dbaa092bf066a9ce561da6a2fc1c293' ========= master_lag: 0.53 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:35.527671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:35.528006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 18:43:35.661562) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-06 18:43:35.661977) ========= /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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:43:35 INFO - MultiFileLogger online at 20160406 18:43:35 in /builds/slave/test 18:43:35 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 18:43:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:43:35 INFO - {'append_to_log': False, 18:43:35 INFO - 'base_work_dir': '/builds/slave/test', 18:43:35 INFO - 'blob_upload_branch': 'Fx-Team', 18:43:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:43:35 INFO - 'branch': 'Fx-Team', 18:43:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:43:35 INFO - 'config_files': ('talos/mac_config.py',), 18:43:35 INFO - 'default_actions': ('clobber', 18:43:35 INFO - 'read-buildbot-config', 18:43:35 INFO - 'download-and-extract', 18:43:35 INFO - 'populate-webroot', 18:43:35 INFO - 'create-virtualenv', 18:43:35 INFO - 'install', 18:43:35 INFO - 'run-tests'), 18:43:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:43:35 INFO - 'download_minidump_stackwalk': True, 18:43:35 INFO - 'download_symbols': 'ondemand', 18:43:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:43:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:43:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:43:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:43:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:43:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:43:35 INFO - 'installer_path': 'installer.exe', 18:43:35 INFO - 'log_level': 'info', 18:43:35 INFO - 'log_name': 'talos', 18:43:35 INFO - 'log_to_console': True, 18:43:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:43:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:43:35 INFO - 'opt_config_files': (), 18:43:35 INFO - 'pip_index': False, 18:43:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:43:35 INFO - 'cmd': ('bash', 18:43:35 INFO - '-c', 18:43:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:43:35 INFO - 'enabled': True, 18:43:35 INFO - 'halt_on_failure': False, 18:43:35 INFO - 'name': 'check_screen_resolution'},), 18:43:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:43:35 INFO - 'cmd': ('bash', 18:43:35 INFO - '-c', 18:43:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:43:35 INFO - 'enabled': True, 18:43:35 INFO - 'halt_on_failure': False, 18:43:35 INFO - 'name': 'check_screen_resolution'},), 18:43:35 INFO - 'run_cmd_checks_enabled': True, 18:43:35 INFO - 'sps_profile': False, 18:43:35 INFO - 'sps_profile_interval': 0, 18:43:35 INFO - 'suite': 'dromaeojs', 18:43:35 INFO - 'system_bits': '32', 18:43:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:43:35 INFO - 'title': 't-yosemite-r7-0158', 18:43:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:43:35 INFO - 'use_talos_json': True, 18:43:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:43:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:43:35 INFO - 'work_dir': 'build'} 18:43:35 INFO - ##### 18:43:35 INFO - ##### Running clobber step. 18:43:35 INFO - ##### 18:43:35 INFO - Running pre-action listener: _resource_record_pre_action 18:43:35 INFO - Running main action method: clobber 18:43:35 INFO - rmtree: /builds/slave/test/build 18:43:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:43:37 INFO - Running post-action listener: _resource_record_post_action 18:43:37 INFO - ##### 18:43:37 INFO - ##### Running read-buildbot-config step. 18:43:37 INFO - ##### 18:43:37 INFO - Running pre-action listener: _resource_record_pre_action 18:43:37 INFO - Running main action method: read_buildbot_config 18:43:37 INFO - Using buildbot properties: 18:43:37 INFO - { 18:43:37 INFO - "project": "", 18:43:37 INFO - "product": "firefox", 18:43:37 INFO - "script_repo_revision": "production", 18:43:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:43:37 INFO - "repository": "", 18:43:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:43:37 INFO - "buildid": "20160406164046", 18:43:37 INFO - "pgo_build": "False", 18:43:37 INFO - "basedir": "/builds/slave/test", 18:43:37 INFO - "buildnumber": 684, 18:43:37 INFO - "slavename": "t-yosemite-r7-0158", 18:43:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:43:37 INFO - "platform": "yosemite_r7", 18:43:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:43:37 INFO - "branch": "fx-team", 18:43:37 INFO - "repo_path": "integration/fx-team", 18:43:37 INFO - "revision": "572875411dbaa092bf066a9ce561da6a2fc1c293", 18:43:37 INFO - "stage_platform": "macosx64", 18:43:37 INFO - "builduid": "987ac747e62a44aa8b92277fe2daee8a", 18:43:37 INFO - "slavebuilddir": "test" 18:43:37 INFO - } 18:43:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:43:37 INFO - Running post-action listener: _resource_record_post_action 18:43:37 INFO - ##### 18:43:37 INFO - ##### Running download-and-extract step. 18:43:37 INFO - ##### 18:43:37 INFO - Running pre-action listener: _resource_record_pre_action 18:43:37 INFO - Running main action method: download_and_extract 18:43:37 INFO - mkdir: /builds/slave/test/build/tests 18:43: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')]} 18:43:37 INFO - https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:38 INFO - Downloaded 1199 bytes. 18:43:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:43:38 INFO - Using the following test package requirements: 18:43:38 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:43:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:43:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:43:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'jsshell-mac.zip'], 18:43:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:43:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:43:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:43:38 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:43:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:43:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:43:38 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:43:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:43:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:38 INFO - https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:43:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:43:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:43:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:39 INFO - Downloaded 17970748 bytes. 18:43:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:43:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 18:43:42 INFO - Return code: 0 18:43:42 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 18:43:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:42 INFO - https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:43:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:43:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:43:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:43 INFO - Downloaded 17970748 bytes. 18:43:43 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'] 18:43:43 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 18:43:46 INFO - Return code: 0 18:43:46 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')]} 18:43:46 INFO - https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:43:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:43:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:43:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:47 INFO - Downloaded 10847617 bytes. 18:43:47 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'] 18:43:47 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 18:43:48 INFO - Return code: 0 18:43: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')]} 18:43:48 INFO - https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/avzfxSmHQrivZDeJrWwM2Q/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 18:43:52 INFO - Downloaded 108915787 bytes. 18:43:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:43:52 INFO - mkdir: /builds/slave/test/properties 18:43:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:52 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:52 INFO - Contents: 18:43:52 INFO - build_url:https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:43:53 INFO - Running post-action listener: _resource_record_post_action 18:43:53 INFO - Running post-action listener: set_extra_try_arguments 18:43:53 INFO - ##### 18:43:53 INFO - ##### Running populate-webroot step. 18:43:53 INFO - ##### 18:43:53 INFO - Running pre-action listener: _resource_record_pre_action 18:43:53 INFO - Running main action method: populate_webroot 18:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:53 INFO - '--tppagecycles', 18:43:53 INFO - '7'], 18:43:53 INFO - 'tests': ['tsvgm']}}, 18:43:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:43:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:43:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:43:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['damp', 'tps']}, 18:43:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'tests': ['damp', 'tps']}, 18:43:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['dromaeo_dom']}, 18:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['a11yr', 18:43:53 INFO - 'ts_paint', 18:43:53 INFO - 'tpaint', 18:43:53 INFO - 'sessionrestore', 18:43:53 INFO - 'sessionrestore_no_auto_restore', 18:43:53 INFO - 'tabpaint']}, 18:43:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['tsvgx', 18:43:53 INFO - 'tsvgr_opacity', 18:43:53 INFO - 'tart', 18:43:53 INFO - 'tscrollx', 18:43:53 INFO - 'cart']}, 18:43:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:43:53 INFO - 'tsvgr_opacity', 18:43:53 INFO - 'tart', 18:43:53 INFO - 'tscrollx', 18:43:53 INFO - 'cart']}, 18:43:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'talos_options': ['--disable-e10s'], 18:43:53 INFO - 'tests': ['tp5o']}, 18:43:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'tests': ['tp5o']}, 18:43:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'talos_options': ['--disable-e10s', 18:43:53 INFO - '--xperf_path', 18:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:53 INFO - 'tests': ['tp5n']}, 18:43:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:53 INFO - 'talos_options': ['--xperf_path', 18:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:53 INFO - 'tests': ['tp5n']}}, 18:43:53 INFO - 'talos.zip': {'path': '', 18:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:53 INFO - Running post-action listener: _resource_record_post_action 18:43:53 INFO - ##### 18:43:53 INFO - ##### Running create-virtualenv step. 18:43:53 INFO - ##### 18:43:53 INFO - Running pre-action listener: _resource_record_pre_action 18:43:53 INFO - Running main action method: create_virtualenv 18:43:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43:53 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 18:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:53 INFO - Using real prefix '/tools/python27' 18:43:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:54 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:57 INFO - Installing pip.................done. 18:43:57 INFO - Return code: 0 18:43:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:57 INFO - 'HOME': '/Users/cltbld', 18:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:57 INFO - 'LOGNAME': 'cltbld', 18:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:57 INFO - 'MOZ_NO_REMOTE': '1', 18:43:57 INFO - 'NO_EM_RESTART': '1', 18:43:57 INFO - 'PAGER': '/bin/cat', 18:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:57 INFO - 'PWD': '/builds/slave/test', 18:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:57 INFO - 'SHELL': '/bin/bash', 18:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:43:57 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:57 INFO - 'USER': 'cltbld', 18:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:57 INFO - 'XPC_FLAGS': '0x0', 18:43:57 INFO - 'XPC_SERVICE_NAME': '0', 18:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:57 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 18:43:57 INFO - Cleaning up... 18:43:57 INFO - Return code: 0 18:43:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 18:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:43:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:43:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:43:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:43:57 INFO - 'HOME': '/Users/cltbld', 18:43:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:43:57 INFO - 'LOGNAME': 'cltbld', 18:43:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:57 INFO - 'MOZ_NO_REMOTE': '1', 18:43:57 INFO - 'NO_EM_RESTART': '1', 18:43:57 INFO - 'PAGER': '/bin/cat', 18:43:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:43:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:57 INFO - 'PWD': '/builds/slave/test', 18:43:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:43:57 INFO - 'SHELL': '/bin/bash', 18:43:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:43:57 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:43:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:43:57 INFO - 'USER': 'cltbld', 18:43:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:43:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:43:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:57 INFO - 'XPC_FLAGS': '0x0', 18:43:57 INFO - 'XPC_SERVICE_NAME': '0', 18:43:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:43:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:57 INFO - Downloading/unpacking psutil>=0.7.1 18:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:43:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:43:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:43:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:44:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:00 INFO - Installing collected packages: psutil 18:44:00 INFO - Running setup.py install for psutil 18:44:00 INFO - building 'psutil._psutil_osx' extension 18:44: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/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 18:44:01 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 18:44:01 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 18:44:01 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 18:44:01 INFO - building 'psutil._psutil_posix' extension 18:44:01 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 18:44:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:44:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:44:01 INFO - ^ 18:44:01 INFO - 1 warning generated. 18:44:01 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 18:44:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:44:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:44:01 INFO - Successfully installed psutil 18:44:01 INFO - Cleaning up... 18:44:01 INFO - Return code: 0 18:44:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:44: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')]} 18:44:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44: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')]} 18:44:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:44:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:44:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:01 INFO - 'HOME': '/Users/cltbld', 18:44:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:01 INFO - 'LOGNAME': 'cltbld', 18:44:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:01 INFO - 'MOZ_NO_REMOTE': '1', 18:44:01 INFO - 'NO_EM_RESTART': '1', 18:44:01 INFO - 'PAGER': '/bin/cat', 18:44:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:01 INFO - 'PWD': '/builds/slave/test', 18:44:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:01 INFO - 'SHELL': '/bin/bash', 18:44:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:01 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:01 INFO - 'USER': 'cltbld', 18:44:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:01 INFO - 'XPC_FLAGS': '0x0', 18:44:01 INFO - 'XPC_SERVICE_NAME': '0', 18:44:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:44:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:44:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:44:04 INFO - Installing collected packages: mozsystemmonitor 18:44:04 INFO - Running setup.py install for mozsystemmonitor 18:44:04 INFO - Successfully installed mozsystemmonitor 18:44:04 INFO - Cleaning up... 18:44:04 INFO - Return code: 0 18:44:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:44:04 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')]} 18:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:04 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')]} 18:44:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:04 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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:04 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 18:44:04 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 18:44:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:04 INFO - 'HOME': '/Users/cltbld', 18:44:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:04 INFO - 'LOGNAME': 'cltbld', 18:44:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:04 INFO - 'MOZ_NO_REMOTE': '1', 18:44:04 INFO - 'NO_EM_RESTART': '1', 18:44:04 INFO - 'PAGER': '/bin/cat', 18:44:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:04 INFO - 'PWD': '/builds/slave/test', 18:44:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:04 INFO - 'SHELL': '/bin/bash', 18:44:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:04 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:04 INFO - 'USER': 'cltbld', 18:44:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:04 INFO - 'XPC_FLAGS': '0x0', 18:44:04 INFO - 'XPC_SERVICE_NAME': '0', 18:44:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:44:05 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 18:44:05 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 18:44:05 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 18:44:05 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 18:44:05 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 18:44:05 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 18:44:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:44:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:44:07 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 18:44:07 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 18:44:07 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 18:44:07 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 18:44:07 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 18:44:07 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 18:44:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:44:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:44:08 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 18:44:08 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 18:44:08 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 18:44:08 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 18:44:08 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 18:44:08 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 18:44:08 INFO - Downloading docopt-0.6.1.tar.gz 18:44:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:44:08 INFO - Installing collected packages: blobuploader, requests, docopt 18:44:08 INFO - Running setup.py install for blobuploader 18:44:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:44:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:44:08 INFO - Running setup.py install for requests 18:44:09 INFO - Running setup.py install for docopt 18:44:09 INFO - Successfully installed blobuploader requests docopt 18:44:09 INFO - Cleaning up... 18:44:09 INFO - Return code: 0 18:44:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:09 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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:09 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 18:44:09 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 18:44:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:09 INFO - 'HOME': '/Users/cltbld', 18:44:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:09 INFO - 'LOGNAME': 'cltbld', 18:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:09 INFO - 'MOZ_NO_REMOTE': '1', 18:44:09 INFO - 'NO_EM_RESTART': '1', 18:44:09 INFO - 'PAGER': '/bin/cat', 18:44:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:09 INFO - 'PWD': '/builds/slave/test', 18:44:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:09 INFO - 'SHELL': '/bin/bash', 18:44:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:09 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:09 INFO - 'USER': 'cltbld', 18:44:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:09 INFO - 'XPC_FLAGS': '0x0', 18:44:09 INFO - 'XPC_SERVICE_NAME': '0', 18:44:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:09 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-9DhQJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:09 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-EKzvVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-5Mn_s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rMav_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-qGxHD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-EnPPjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-4MjhKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-1rj5mM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-CIKn46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rNP1DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-WjRvi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:10 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-rBifzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:11 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-2w2Gnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:11 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-IDM6pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:11 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-yF7AHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:11 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-kfQ12Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:11 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-tzg9pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:44:11 INFO - Running setup.py install for manifestparser 18:44:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:44:11 INFO - Running setup.py install for mozcrash 18:44:11 INFO - Running setup.py install for mozdebug 18:44:11 INFO - Running setup.py install for mozdevice 18:44:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Running setup.py install for mozfile 18:44:12 INFO - Running setup.py install for mozhttpd 18:44:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Running setup.py install for mozinfo 18:44:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Running setup.py install for mozInstall 18:44:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:44:12 INFO - Running setup.py install for mozleak 18:44:12 INFO - Running setup.py install for mozlog 18:44:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Running setup.py install for moznetwork 18:44:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Running setup.py install for mozprocess 18:44:13 INFO - Running setup.py install for mozprofile 18:44:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Running setup.py install for mozrunner 18:44:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:44:13 INFO - Running setup.py install for mozscreenshot 18:44:13 INFO - Running setup.py install for moztest 18:44:13 INFO - Running setup.py install for mozversion 18:44:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:44:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:44:14 INFO - Cleaning up... 18:44:14 INFO - Return code: 0 18:44:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:14 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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:14 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 18:44:14 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 18:44:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:14 INFO - 'HOME': '/Users/cltbld', 18:44:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:14 INFO - 'LOGNAME': 'cltbld', 18:44:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:14 INFO - 'MOZ_NO_REMOTE': '1', 18:44:14 INFO - 'NO_EM_RESTART': '1', 18:44:14 INFO - 'PAGER': '/bin/cat', 18:44:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:14 INFO - 'PWD': '/builds/slave/test', 18:44:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:14 INFO - 'SHELL': '/bin/bash', 18:44:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:14 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:14 INFO - 'USER': 'cltbld', 18:44:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:14 INFO - 'XPC_FLAGS': '0x0', 18:44:14 INFO - 'XPC_SERVICE_NAME': '0', 18:44:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-H4m5Hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:44:14 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)) 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-IqUyJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:44:14 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)) 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-roNamg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:44: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)) 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-ac64jI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:44: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)) 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-D_uviN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:44: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)) 18:44:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:44:14 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-XqUP7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-N4NEfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-2S4DzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-xE4cpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-GLa_H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-G7Jo5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:44:15 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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-pHDp7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:44: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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-2Q4eWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:44: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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-a9tRDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:44: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)) 18:44:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:15 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-VHT0vH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:44:16 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)) 18:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:44:16 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-eiiQ7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:44:16 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)) 18:44:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:44:16 INFO - Running setup.py (path:/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/pip-lnCgDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:44:16 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)) 18:44:16 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)) 18:44:16 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)) 18:44:16 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)) 18:44:16 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)) 18:44:16 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)) 18:44:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:18 INFO - Downloading blessings-1.6.tar.gz 18:44:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:44:18 INFO - Installing collected packages: blessings 18:44:18 INFO - Running setup.py install for blessings 18:44:18 INFO - Successfully installed blessings 18:44:18 INFO - Cleaning up... 18:44:19 INFO - Return code: 0 18:44:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:44:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:19 INFO - Reading from file tmpfile_stdout 18:44:19 INFO - Current package versions: 18:44:19 INFO - blessings == 1.6 18:44:19 INFO - blobuploader == 1.2.4 18:44:19 INFO - docopt == 0.6.1 18:44:19 INFO - manifestparser == 1.1 18:44:19 INFO - mozInstall == 1.12 18:44:19 INFO - mozcrash == 0.17 18:44:19 INFO - mozdebug == 0.1 18:44:19 INFO - mozdevice == 0.48 18:44:19 INFO - mozfile == 1.2 18:44:19 INFO - mozhttpd == 0.7 18:44:19 INFO - mozinfo == 0.9 18:44:19 INFO - mozleak == 0.1 18:44:19 INFO - mozlog == 3.1 18:44:19 INFO - moznetwork == 0.27 18:44:19 INFO - mozprocess == 0.22 18:44:19 INFO - mozprofile == 0.28 18:44:19 INFO - mozrunner == 6.11 18:44:19 INFO - mozscreenshot == 0.1 18:44:19 INFO - mozsystemmonitor == 0.0 18:44:19 INFO - moztest == 0.7 18:44:19 INFO - mozversion == 1.4 18:44:19 INFO - psutil == 3.1.1 18:44:19 INFO - requests == 1.2.3 18:44:19 INFO - wsgiref == 0.1.2 18:44:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:19 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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:19 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 18:44:19 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 18:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:19 INFO - 'HOME': '/Users/cltbld', 18:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:19 INFO - 'LOGNAME': 'cltbld', 18:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:19 INFO - 'MOZ_NO_REMOTE': '1', 18:44:19 INFO - 'NO_EM_RESTART': '1', 18:44:19 INFO - 'PAGER': '/bin/cat', 18:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:19 INFO - 'PWD': '/builds/slave/test', 18:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:19 INFO - 'SHELL': '/bin/bash', 18:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:19 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:19 INFO - 'USER': 'cltbld', 18:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:19 INFO - 'XPC_FLAGS': '0x0', 18:44:19 INFO - 'XPC_SERVICE_NAME': '0', 18:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 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)) 18:44:19 INFO - Cleaning up... 18:44:19 INFO - Return code: 0 18:44:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:19 INFO - 'HOME': '/Users/cltbld', 18:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:19 INFO - 'LOGNAME': 'cltbld', 18:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:19 INFO - 'MOZ_NO_REMOTE': '1', 18:44:19 INFO - 'NO_EM_RESTART': '1', 18:44:19 INFO - 'PAGER': '/bin/cat', 18:44:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:19 INFO - 'PWD': '/builds/slave/test', 18:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:19 INFO - 'SHELL': '/bin/bash', 18:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:19 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:19 INFO - 'USER': 'cltbld', 18:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:19 INFO - 'XPC_FLAGS': '0x0', 18:44:19 INFO - 'XPC_SERVICE_NAME': '0', 18:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:19 INFO - Downloading/unpacking jsonschema 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:44:22 INFO - Downloading/unpacking functools32 (from jsonschema) 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:22 INFO - Downloading functools32-3.2.3-2.tar.gz 18:44:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:44:22 INFO - warning: no files found matching '*.txt' 18:44:22 INFO - no previously-included directories found matching 'build' 18:44:22 INFO - no previously-included directories found matching 'dist' 18:44:22 INFO - no previously-included directories found matching '.git*' 18:44:22 INFO - Installing collected packages: jsonschema, functools32 18:44:22 INFO - Running setup.py install for functools32 18:44:22 INFO - warning: no files found matching '*.txt' 18:44:22 INFO - no previously-included directories found matching 'build' 18:44:22 INFO - no previously-included directories found matching 'dist' 18:44:22 INFO - no previously-included directories found matching '.git*' 18:44:22 INFO - Successfully installed jsonschema functools32 18:44:22 INFO - Cleaning up... 18:44:23 INFO - Return code: 0 18:44:23 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:44:23 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 0x108a71a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a81420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9862489b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, '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.0jbSYLByzd/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.jSsy0H3SYa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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 18:44:23 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 18:44:23 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 18:44:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:44:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:44:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:44:23 INFO - 'HOME': '/Users/cltbld', 18:44:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:44:23 INFO - 'LOGNAME': 'cltbld', 18:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:23 INFO - 'MOZ_NO_REMOTE': '1', 18:44:23 INFO - 'NO_EM_RESTART': '1', 18:44:23 INFO - 'PAGER': '/bin/cat', 18:44:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:23 INFO - 'PWD': '/builds/slave/test', 18:44:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:44:23 INFO - 'SHELL': '/bin/bash', 18:44:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:44:23 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:44:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:44:23 INFO - 'USER': 'cltbld', 18:44:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:44:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:23 INFO - 'XPC_FLAGS': '0x0', 18:44:23 INFO - 'XPC_SERVICE_NAME': '0', 18:44:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:44:23 INFO - Downloading/unpacking flake8 18:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:44:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:44:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44: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 18:44:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:44:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 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 18:44:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:27 INFO - no previously-included directories found matching 'docs/_build' 18:44:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:44:27 INFO - Running setup.py install for pep8 18:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:44:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:44:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:44:27 INFO - no previously-included directories found matching 'docs/_build' 18:44:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:44:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:44:27 INFO - Cleaning up... 18:44:27 INFO - Return code: 0 18:44:27 INFO - Running post-action listener: _resource_record_post_action 18:44:27 INFO - Running post-action listener: _start_resource_monitoring 18:44:27 INFO - Starting resource monitoring. 18:44:27 INFO - ##### 18:44:27 INFO - ##### Running install step. 18:44:27 INFO - ##### 18:44:27 INFO - Running pre-action listener: _resource_record_pre_action 18:44:27 INFO - Running main action method: install 18:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:44:27 INFO - Reading from file tmpfile_stdout 18:44:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:44:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:44:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:44:27 INFO - Reading from file tmpfile_stdout 18:44:27 INFO - Output received: 18:44:27 INFO - Usage: mozinstall [options] installer 18:44:27 INFO - Options: 18:44:27 INFO - -h, --help show this help message and exit 18:44:27 INFO - -d DEST, --destination=DEST 18:44:27 INFO - Directory to install application into. [default: 18:44:27 INFO - "/builds/slave/test"] 18:44:27 INFO - --app=APP Application being installed. [default: firefox] 18:44:27 INFO - mkdir: /builds/slave/test/build/application 18:44: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'] 18:44: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 18:45:00 INFO - Reading from file tmpfile_stdout 18:45:00 INFO - Output received: 18:45:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:45:00 INFO - Running post-action listener: _resource_record_post_action 18:45:00 INFO - ##### 18:45:00 INFO - ##### Running run-tests step. 18:45:00 INFO - ##### 18:45:00 INFO - Running pre-action listener: _resource_record_pre_action 18:45:00 INFO - Running main action method: run_tests 18:45:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:45:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:45:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:45:00 INFO - 2016-04-06 18:45:00.631 screenresolution[2204:16579] starting screenresolution argv=screenresolution get 18:45:00 INFO - 2016-04-06 18:45:00.634 screenresolution[2204:16579] Display 0: 1600x1200x32@60 18:45:00 INFO - 2016-04-06 18:45:00.640 screenresolution[2205:16581] starting screenresolution argv=screenresolution list 18:45:00 INFO - Available Modes on Display 0 18:45:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:45:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:45:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:45:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:45:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:45:00 INFO - Intel Iris: 18:45:00 INFO - Chipset Model: Intel Iris 18:45:00 INFO - Type: GPU 18:45:00 INFO - Bus: Built-In 18:45:00 INFO - VRAM (Dynamic, Max): 1536 MB 18:45:00 INFO - Vendor: Intel (0x8086) 18:45:00 INFO - Device ID: 0x0a2e 18:45:00 INFO - Revision ID: 0x0009 18:45:00 INFO - Displays: 18:45:00 INFO - Display: 18:45:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:45:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:45:00 INFO - Display Serial Number: 1600x1200 60 18:45:00 INFO - Main Display: Yes 18:45:00 INFO - Mirror: Off 18:45:00 INFO - Online: Yes 18:45:00 INFO - Rotation: Supported 18:45:00 INFO - Return code: 0 18:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:45:00 INFO - Python 2.7.3 18:45:00 INFO - Return code: 0 18:45:00 INFO - grabbing minidump binary from tooltool 18:45: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')]} 18:45:00 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 0x108910e00>, '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 0x108739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10890bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:45:00 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 18:45:00 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 18:45:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:45:00 INFO - Return code: 0 18:45:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:45:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:45:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:45:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:45:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:45:02 INFO - Return code: 0 18:45: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/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 18:45: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/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0158 --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 18:45:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0jbSYLByzd/Render', 18:45:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:45:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:45:02 INFO - 'HOME': '/Users/cltbld', 18:45:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:45:02 INFO - 'LOGNAME': 'cltbld', 18:45:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:45:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:45:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:45:02 INFO - 'MOZ_NO_REMOTE': '1', 18:45:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:45:02 INFO - 'NO_EM_RESTART': '1', 18:45:02 INFO - 'PAGER': '/bin/cat', 18:45:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:45:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:45:02 INFO - 'PWD': '/builds/slave/test', 18:45:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:45:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:45:02 INFO - 'SHELL': '/bin/bash', 18:45:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jSsy0H3SYa/Listeners', 18:45:02 INFO - 'TMPDIR': '/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/', 18:45:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:45:02 INFO - 'USER': 'cltbld', 18:45:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:45:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:45:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:45:02 INFO - 'XPC_FLAGS': '0x0', 18:45:02 INFO - 'XPC_SERVICE_NAME': '0', 18:45:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:45: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/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0158', '--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 18:45:02 INFO - mozversion application_buildid: 20160406164046 18:45:02 INFO - mozversion application_changeset: 572875411dbaa092bf066a9ce561da6a2fc1c293 18:45:02 INFO - mozversion application_display_name: Nightly 18:45:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:45:02 INFO - mozversion application_name: Firefox 18:45:02 INFO - mozversion application_remotingname: firefox 18:45:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:45:02 INFO - mozversion application_vendor: Mozilla 18:45:02 INFO - mozversion application_version: 48.0a1 18:45:02 INFO - mozversion platform_buildid: 20160406164046 18:45:02 INFO - mozversion platform_changeset: 572875411dbaa092bf066a9ce561da6a2fc1c293 18:45:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:45:02 INFO - mozversion platform_version: 48.0a1 18:45:02 INFO - using testdate: 1459993502 18:45:02 INFO - actual date: 1459993502 18:45:02 INFO - starting webserver on 'localhost:51977' 18:45:02 INFO - SUITE-START | Running 2 tests 18:45:02 INFO - TEST-START | dromaeo_css 18:45:02 INFO - operating with platform_type : mac_ 18:45:02 INFO - Initialising browser for dromaeo_css test... 18:45:02 INFO - TEST-INFO | started process 2223 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpU7HcoI/profile http://localhost:51977/getInfo.html) 18:45:04 INFO - PROCESS | 2223 | __metrics Screen width/height:1600/1200 18:45:04 INFO - PROCESS | 2223 | colorDepth:24 18:45:04 INFO - PROCESS | 2223 | Browser inner width/height: 1024/689 18:45:04 INFO - PROCESS | 2223 | __metrics 18:45:04 INFO - PROCESS | 2223 | 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" 18:45:04 ERROR - PROCESS | 2223 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:45:05 INFO - TEST-INFO | 2223: exit 0 18:45:05 INFO - Browser initialized. 18:45:05 INFO - Running cycle 1/1 for dromaeo_css test... 18:45:05 INFO - TEST-INFO | started process 2225 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmpU7HcoI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:17 INFO - PROCESS | 2225 | RSS: Main: 236740608 18:45:17 INFO - PROCESS | 2225 | 18:46:08 INFO - PROCESS | 2225 | 1459993568460 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] 18:48:18 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51977/tests/dromaeo/cssquery-ext.html) 18:48:20 INFO - PROCESS | 2225 | RSS: Main: 373313536 18:48:20 INFO - PROCESS | 2225 | 18:51:22 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-ext.html (next: http://localhost:51977/tests/dromaeo/cssquery-jquery.html) 18:51:23 INFO - PROCESS | 2225 | RSS: Main: 367153152 18:51:23 INFO - PROCESS | 2225 | 18:54:25 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51977/tests/dromaeo/cssquery-mootools.html) 18:54:26 INFO - PROCESS | 2225 | RSS: Main: 365813760 18:54:26 INFO - PROCESS | 2225 | 18:57:28 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51977/tests/dromaeo/cssquery-prototype.html) 18:57:28 INFO - PROCESS | 2225 | RSS: Main: 324857856 18:57:28 INFO - PROCESS | 2225 | 19:00:31 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51977/tests/dromaeo/cssquery-yui.html) 19:00:32 INFO - PROCESS | 2225 | RSS: Main: 329191424 19:00:32 INFO - PROCESS | 2225 | 19:03:34 INFO - PROCESS | 2225 | Cycle 1(1): loaded http://localhost:51977/tests/dromaeo/cssquery-yui.html (next: http://localhost:51977/tests/dromaeo/cssquery-dojo.html) 19:03:35 INFO - PROCESS | 2225 | RSS: Main: 375709696 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | __start_tp_report 19:03:35 INFO - PROCESS | 2225 | _x_x_mozilla_page_load 19:03:35 INFO - PROCESS | 2225 | _x_x_mozilla_page_load_details 19:03:35 INFO - PROCESS | 2225 | |i|pagename|runs| 19:03:35 INFO - PROCESS | 2225 | |0;dojo.html;3008.924776880579;3231.208353953282;3375.2405708715532;3457.8616855325795;3500.5274287971115;4579.977100114499;5527.917081243784;5593.692346920918;5651.434856514346;5671.376148623648;5581.134924086763;5591.664500129995;5618.550515958724;5625.6905870177225;5630.352509461413;5057.393112826466;5065.696058236499;5097.617678674096;5141.562967147797;5155.407128180251;5102.413222479426;5165.76754046067;5166.535011848933;5166.9224961625605;5176.223566465042;4230.259704551707;5115.079285728568;5134.948650513503;5156.175011998081;5159.071367153911;5137.434882162959;5175.637705360627;5187.714675692835;5189.896202075937;5259.26370308159;5001.374828146481;5013;5109;5149.2791009258735;5150.948490515084;5533.059379905426;5555.027870122713;5557.138643510262;5577.553795696334;5630.09918413056;6175.475084617813;6181.258249010102;6181.289151747562;6189.978653522164;6199.442050215457;6073.089036644495;6115.143879856823;6216.813495595139;6231.750729970796;6248.812535623939;5783.8554036149435;5785.5660825437835;5795.275590551181;5829.912551311733;5843.561732869966;6230.302788526701;6267.5299352548745;6274.466670332981;6282.415886203838;6296.338884417162;5982.581219314693;6018.668973206516;6076.513878889678;6086.482648974798;6104.38956104386;6190.8230152949245;6214.223222097238;6246.875062498724;6247.187865577446;6251.906221406592;6196.256449226122;6197.876042479125;6200.81397558074;6203.348648391854;6209.813705588839;6060.848478788065;6102.481289090389;6144.279601711528;6183.979643358885;6197.163382943335;4901.975490122527;4905.7301848397965;4908.239222920453;4909.729964851967;4935.580475659537;4411.889702757457;4418.668599855024;4422.513523512411;4424;4470;5374.704391258519;5523.309586301712;5525.751341189656;5539.307586551681;5540.058190107691;6156.938430615636;6164.537659675452;6260.937390626035;6279.372062793684;6284.057391391328;5508.421615730371;5510.834674959758;5523.337199536001;5528.917066244009;5530.6128570999645;5237.764300606482;5323.973380133075;5340.652857564246;5354.839354819362;5355.196720491957;5457.072297709319;6116.66358350295;6180.6291622502795;6238.251409830758;6277.686115694106;6182.350853160354;6194.907076393948;6200.503959683305;6201.720922558406;6202.7208775606105;6155.907661385172;6204.193454850841;6207.782727604512;6233.657148856856;6326.9683651581445;6100.511959043177;6147.96926015385;6159.045347971071;6161.599496032743;6178.227721534809;6189.412005859436;6256.186695729526;6258.030005349178;6260.718267678057;6275.6548389839;5931.555133364928;6025.608335458356;6102.084687296941;6115.143879856734;6117.021276595723;5974.581779275409;6032.883916475466;6087.421694938974;6094.695265236809;6119.051547010221;5940.584159108821;5949.524038076857;5951.464368206882;5957.523398128226;5966.791162309299;5824;5911.142884281841;6016.7292471838;6090.817275481742;6101.633901965896;5872.500837428695;5916.467517923407;5969.641821490724;5989;6022.48808851235 19:03:35 INFO - PROCESS | 2225 | |1;ext.html;450.7768654516015;570.640496487213;573.810642487979;621.9813405597831;627.5450298533564;29526.852365738167;37776.433353499684;38078.809605952;38109.61890381092;38142.8092859536;41031;41607;41677.791611041976;41723.791381043055;41804.79097604515;9435;9674;9692.75768105796;9703.126718595326;9706;9489.335746497747;9651.083147101013;9655.46894920779;9658.517074146299;9665.226781857435;9020.594073266719;9215.493147876865;9601.711948641552;9693.951530242339;9799.95100024499;9680.564374603124;9773.51132443382;9778.41329520231;9783.608655653765;9786.706398808046;9598.712038638781;9628.855567166498;9634.325597208199;9722.951385243028;9743.61025558984;40220.59779402227;40513.392299115534;40629;40686;40850.591494084976;3196.408664397094;3294.456414691597;3628.963710362889;3679.9880032990873;3807.733458657895;28118.718812811814;29147;29577.408451830845;29761.553576696366;29833.10500684983;2733.1937078561873;2738.753512183913;2770.7644850187758;2829.3775369418695;2870.8277503349864;481149.59425203;481826;483024;483757;483900;45267.77366113148;45939.310910336375;46140.30789538159;65393.34606653968;65786.67106664531;45200.77399612981;45210.38316934637;45257.54742452599;45427.54572454299;45456.318155227695;12708.046896482801;15579.221038948008;15631.921840390725;15643.139627320379;15646.921765391327;12518.74962500745;12592.181508201938;12598.496060157675;12618.684532886567;12624.81062784059;14793.92603036978;14823.925880370529;14827;14831.40674373013;14947.70104597902;6307.26550198699;6453.838654033687;6463.450606698483;6477.5465717400275;6491.51313651478;951.8143961927497;959.5250351076122;969.6170012844887;976.3360914578155;1089.6622047165404;28909.71090289112;28964.84140634393;29530.114096577137;29703.554446683316;29727.40545189084;1053.5733028123623;1059.5496913811598;1073.5652060915343;1089.2593036734938;1132.5073592987078;11076.501557429934;14098.365573549216;14679.706405871822;14883.846165352808;14977.925110374379;536093;539411;540183;541952;544478;58177.4182258172;58512.4148758507;59058.11412828811;59101;59115.81768364694;1334.1861464506644;1365.9795103073661;1456.3228098934046;1466.1789397937189;1493.059372595258;24023.621656493753;24334.63498047495;30561.388772224876;30820.383592328475;30903.536446953764;53215.669608260105;53534;53818.73090634522;54031.72984135054;54215.72892135514;416441;418258;418931;420491;421616;28050.438991220468;29178.854105729337;31197.8440107798;33419.331613368086;33638;41233.79383103185;41642;41997.95005124896;42026.739197824114;42445.78777106095;34202.31595368029;34412;34563.48154777731;35193.82403087968;35214.82392588123;33898.49152262669;33991.4901276486;34340.656593434745;34718.47922281118;34936.12659683528;35466.822665887536;35771.28457430889;35973.82013089918;36283.637163628024;36619.81690091533;31180.376392472477;31639.985628169048;31642.525362119126;31723.682763172073;31824.04527864168;22790;24090.39774005664;24281.028758849447;24281.150159744324;24296.635550467112 19:03:35 INFO - PROCESS | 2225 | |2;jquery.html;362.23929747530184;363.77082438063997;364.6426502028012;374.305662995144;375.84214629855455;15492.838037147218;18606;19647.31234406796;20051.29820456284;20057.29799457019;18843.24627014918;19417;20198;20223.191072357087;20242.089105990228;5567.387587365387;5771;5781.421857814227;5786.1610066540325;5789.710514474281;4117.958820411787;4312.762798046107;4331.501877284106;5748.741306641211;6272.68636568172;5757.942420575782;5942.781729745413;6272.937270627281;6280.623162610258;6291.653959032252;6071.574989750719;6194.628322300677;6269.592476489036;6270.968645156745;6271.5923464975085;3644.398674218751;5143.305653736735;5390.353157621111;5400.432954539756;5420.864478388033;23781.7621823783;23991.7600823993;24213.636795447906;25370.873145634338;25382.238532844043;2120.97132890548;2194.1004188282727;2243.304575581575;2276.6926464927187;2772.987859431313;6814.250432452426;7084.716611335541;7572.469927105105;13882.167069975732;14691.706165876729;1658.552190908448;1703.2335449047978;1732.610162713392;1736.114581563399;1758.4109323376556;99936;102791;102824;102843;103221;9764.365316254563;9865.901340986642;10110.342827716322;10133.290669653054;10286.382817031003;12630.115891887663;12641;12671.873281267253;12677.492900284069;12686.49254029847;8344.707935222237;8364.539950302791;8385.287250583646;8418.621162047722;8460.492370457792;8637.870431943526;8657.913420865836;8692.261157801659;8734.650613975497;8745.47527148373;4861.347141971746;4967.304577359173;5947.256592925884;5963.890276287317;5987.251593550806;1653.8180800111977;1722.9913850430667;1730.7749992500894;1740.634466761969;1821.6629923463936;888.9333300002526;909.5406819556082;963.9759006024906;972.9027097290215;1000.3347773730388;19517.609647806963;20560;20624.896875515526;20664.276750313667;20875;990.4354517924858;999.2954966748425;1003.087190656499;1009.7223263602568;1031.2471895516314;9262.583183756613;10644.840327395095;11164.162687798447;11190.992810646918;11321.433928303552;530396;611165;624189;643076;643548;59945.70027149836;87917.56041219753;99863.00136998683;100815.9573883374;101473;947.1144479911305;987.8616993620899;1038.6364772329623;1058.3491152940885;1060.4379678770265;14342.354594043085;17927.73108403401;17970.011649358887;18006.72989905179;18306.633867322846;40284.798576006935;42467.7876610615;42979.355309671;43259.134817302845;43410.78294608507;59127.81744365003;60122;60354.79290414255;60414;60456.09315860354;7379.2251813558805;7489.28851759082;7539.660715267936;7667.501612395176;7940.483868548526;12187.390630468264;12329.383530823603;12410;12719.55481558141;12806.61580152597;10652.84020739674;10737.677869663923;10860.565577376816;11025.44872756375;11250.212485125963;5178.249153872743;9548.236141108833;10444.321119127233;10842.241043126905;10876.673699789018;11183.608573699881;11449.771004580029;11509.424528773361;11555.480003400035;11678.532858685898;7853.1361550228285;7927.167647397171;7984.321332686554;8034.638441270274;8071.556064416279;9861.211103111877;10862.945685271523;11172.441377931233;11219.495122719334;11251.268667536584 19:03:35 INFO - PROCESS | 2225 | |3;mootools.html;1419.4393214680194;1539.699758547083;1578.2897696036782;1841.8894866308021;1998.2406685459523;7910.982699411649;8598.312135029199;8739.956300218506;8755.868661970075;8768.780780480483;8499.235068843804;8690.17443342883;8715.520646364448;8738.388312818106;8746.300295976322;2165.133946421436;2417.987910060447;2461.9753802462014;2477.2196758021164;2495.3137887081107;2510.0336370497307;2518.7733104020635;2519.370157460635;2522.1802914052914;2525.7979361651114;2047.2834507922257;2402.411409204747;2457.778799908008;2457.9262622121364;2459.102427613926;1979;2230.353197572702;2309.214866945238;2466.3957330454155;2470.8146888983397;2423.4183795889035;2460.938476538083;2466.77798998091;2469.8888550015295;2470.2465747946867;8731.345149113842;8809.86785198216;8839.204471597523;8859.114088591154;8874;5399.37907140676;5576.386597474275;5601.663900165962;5602.24369710088;5603.467670571289;3572.464130380438;3620.2216523447587;3692.1692619160744;3699.445083237509;3705.277470893177;1034.4155552113032;1054.5781687325054;1061.103367654331;1063.2079101069676;1070.2401295080424;11988.400579971054;12028.69928251792;12041.698957526045;12054.879451205376;12062.517499300018;4834.154023045953;4887.193613053877;4905.264210368473;4952.653314268039;4971.950280497221;9975.152112070411;9976.551055202533;9997.400155990665;10000;10027.849582256125;5555.2222688823595;5561.082421400504;5573.721313934287;5577.637453565587;5595.048841696921;4470.888227794266;4571.154336447701;4857.975710121497;4966.850994470172;5008.323876276656;3317.8102452381313;3845.7884816335372;3918;3929.842806287774;3982.203559288154;1296.3194322980323;1316.5918565244804;1322.966925826862;1337.525178561616;1339.4575197045017;1326.8275124233787;1345.3206130903832;1356.4506374918174;1373.6771858613217;1389.0554422992461;8105.878411823827;8224.136465671018;8246;8271.296939760068;8275.586220688941;514.3133916221811;521.3717470448101;528.7065678548443;528.9814856480082;531.6544246239897;6172.290186628506;6181.660008699565;6190.659513726699;6210.975189093749;6235.906461403082;10352.689419317432;10681.732956675989;10700.090492308085;10763.46182690878;10809.67570972872;10228.846567301496;10602.25784195099;10607.681769546925;10660.786784264272;10692.839607405895;8203.958980205061;8282.461639993382;8302.335813135056;8303.750887473385;8379.078301386964;7633.885491717518;7852.882206767017;7863.646135924012;7873.724419645285;7906.960465197637;9189.908100918905;9450.102240287162;9605.711828645151;9680.854787178057;9719.951400242953;9688.515574221401;9931;10011.449370284414;10033.749156271151;10141.594336226468;6664.233613134552;6855.108835851307;7311.524750891388;7410.036695229585;7502.287282708134;8219.917800821915;8231.176882311722;8262.462939908886;8270.586470676562;8289.33685305162;7231.204567497466;7299.233580474186;7334.486585939147;7422.8144296390865;7431.256874312526;7036.366726994595;7185.461090418135;7217.963910180415;7229.192701824544;7244.492885497964;7471.439642026761;7590.734324298623;7596.962015189889;7599.316061554266;7600.771976840703;6839.829004274734;6877.071595334566;6941.75703850383;6945;6945.409640180641;6965.407940325129;6966.895496567657;6975.128108986377;6976.127984002;7005.789826305219 19:03:35 INFO - PROCESS | 2225 | |4;prototype.html;318.5397101188783;324.78726434185614;326.2528809027327;333.70133730311386;335.58220016079986;6484.092227088206;6498.090267362567;6561.475081993435;6562.081308616797;6593.901091483632;6410.903836442445;6465.191851018622;6477.90283145752;6481.31946145655;6500.902486462707;4586.289125185602;4668;4709.270063140219;4816;4853.08814711174;4774.379330687006;4804.5916097131785;4805.471398146201;4809.735464549466;4812.759362031902;3916.843326266946;4771.42742870856;4778.665493415462;4786.83246086387;4804.1352556539805;3815.828287727059;4505.932411013838;4604.240300350421;4716.834910778106;4724.362211101492;4080.163926233207;4092.9795351023054;4102.200070986159;4103.056297051665;4104.958950410517;6179.258488981306;6191.288001879797;6192.845178870519;6207.099970504297;6239.688015599248;5706.71466426677;5710.428957104298;5723.141528770676;5724.627899186539;5746.770129194827;6923.619200943946;6927.134108236471;6935.133108361455;6940.514164008521;6947.652617369162;4497.415336006331;4670.813167473297;4685.718856868599;4695.835645752416;4696.859094227145;7082.504224704273;7341.229170937028;7350.301721336465;7350.816229594249;7360.116785985716;4759.857204283877;4773.331733557305;4775.331453596499;4775.689580177277;4776.450708168536;4033.9596604034173;4853.02939412119;4854.635902307341;4867.5132486751045;4872.098661747517;5126.974365128151;5708.4862362387585;5716.885662286731;5724.198612194296;5727.39862314451;6440.516961227927;6667.499937504706;6953.4089602384365;6971.721131154697;7038.085048943604;1660.9501714948572;1670.4320531019512;1688.2318545061967;1692.2723229011397;1696.3129932377408;1030.855680204772;1063.4788953412772;1088.080571916729;1088.4394536813547;1118.798616249083;6313.116163737081;6354.046892965999;6382.234131904202;6387.584806987531;6428.774992875227;5870.3249126350165;7084.9726789615215;7295.489315747953;7304.196538380774;7333.669984850588;6438.291787903327;6441.967790161113;6463.838404039937;6517;6584.242812076673;3808.447775072599;3846.7114966377635;3855.1711382052995;3860;3866.2654095721723;7230;7530.472866899374;7537.472376933562;7562.697492100255;7569.5079819811535;7467.141278752904;7489.063867016623;7514.586697731568;7514.812129696801;7528.698852045966;7512.8873066905135;7535.246475352531;7536.359409450258;7543.207963163899;7544.0569928758905;6923.792286231421;7262.419006479363;7283.635818209174;7283.854322913406;7285.089363829521;6473.255575608865;6518.543701941008;7169.749058783126;7175.497715160098;7198;6526.608403495806;6749.93250067493;7489.812754681177;7505.399568034435;7541.170471248268;4796.37647105874;4804.453639571033;4809.807607695793;4819.734914579732;4829.613630909589;7213.855722885618;7231.819204519929;7238.23998480173;7241.818954525968;7251.23861994483;6720.361565651256;6988.895166572607;6999.09011828459;7058.505904586629;7072.71709131629;7004.704129736015;7046.894296585658;7047.119110111236;7050.294970502909;7056.682449289691;6893.620850853251;6903.0335752995625;6904.447644188353;6904.792856214322;6915.308469153246;6789.490788191004;7005.159380874327;7023.964880175567;7039.296070392919;7046.859062818612;5927.733252003756;6649.900251496135;6729.865402692017;6821.965890170517;6922.550034247758 19:03:35 INFO - PROCESS | 2225 | |5;yui.html;694.8401867570459;720.2761224968906;757.1330826203997;760.6424980259278;778.5250996891898;14731.116133032012;14748.852511474883;14864.925675371634;14878.181700006482;14885.479008234714;13662.180269183857;13664.863351366483;13732.038757286993;13739.17564946104;13757.380917858696;727.4834867244263;732.0337154955461;890.3366991591257;912.9908700912972;913.137085454246;887.6538150121457;911.8677791720197;912.4935660708304;913.3834661603424;913.9908600913973;950.5532399772096;961.8316794560924;962.903709629035;966.50708138849;967.0764419978904;755.2447552447552;768.4160038370878;769.8922150898878;948.4972964328916;950.538988590533;576.8759716660896;701.9087518622597;716.5485743981259;716.7168968257561;719.4999475364624;14510.984231103826;14665.04677195979;14680.706385872223;14685.632859178499;14692.26538673062;12317.384130793514;12354.135210535265;12379.876201237963;12642.431090600945;12831.679208019781;9620.71137865865;9836.508174591241;9937;10219.591216351337;10285.485725713685;3455.94816077759;3495.1611613212644;3524.3303772283184;3542.468629705539;3593.4969104325414;78562;80356;81702.54892353299;82387.5880620599;82475.5876220621;7991;9530.428174309563;9541.379810312308;9785.021497850157;9875.60497580103;21582.89208553947;21585.67621485679;21587.136514539558;21589.67615485769;21642.24252151167;6651.102101216274;7175.461840361993;7353.419014911819;7539.623018849035;7664.501807382502;4025.2955732747237;4029.1538776857187;4037.8990525237105;4057.797110144481;4067.6949228807957;3507.000504856104;3539.3275277697153;3564.2336897567147;3568.6966607838103;3570.589382221026;641.3586413586413;651.6611362091686;665.7736369634348;666.0641798273336;666.7832954289876;513.0662194805418;576.7058800012024;579.5305802300151;582.528152196722;595.7319206357157;7733;8196.959015204886;8205.58972051395;8299.385693506527;8314.916850831414;568.2186992884783;578.4475825586554;580.8896309701228;604.7671646416073;617.2685367839125;3088.675689052662;3288.901332960015;3722.2555488902326;3762.3227818992295;3910.276598829226;87169.12830871737;88087;89832;90814;91349;78681;78866.21133788589;79445;79452.4109517818;80270;66526.33473665202;66653;67607.3239267601;68107;70628.6468567654;7594.164641889498;7667.194944530744;7670.42471814605;7882.84234315299;7946.7615971520945;49149.017019660125;49528.50471495239;49573;50719.2392114126;52203;65578.68842623025;65747;65765.68468630697;66575;66678.66660666665;10875.564977401133;11067;11122.555097796321;11138.888611113785;11193.160512961724;11560.544736672482;11602.535898563963;11696.06431485496;11817.763644726885;11843.940780296043;10359.482025898524;11401.828972565252;11498.540058397904;11571.884281157081;11648.76702465929;11401.486933087865;11499.597514086967;11579.131565132817;11762.82355764647;12061.336626485627;11229.719257018312;11260.493277802683;11266.605668801552;11508.48211830453;11522.078233741113;9279.072092790668;9363.204127648954;9534.659277463195;9555.952220238854;9603.663871764455;9507;9664.613415463584;9693.6122555097;9770.560324785543;9842.832195586636 19:03:35 INFO - PROCESS | 2225 | __end_tp_report 19:03:35 INFO - PROCESS | 2225 | __start_cc_report 19:03:35 INFO - PROCESS | 2225 | _x_x_mozilla_cycle_collect,1393 19:03:35 INFO - PROCESS | 2225 | __end_cc_report 19:03:35 INFO - PROCESS | 2225 | __startTimestamp1459994615155__endTimestamp 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | ------- Summary: start ------- 19:03:35 INFO - PROCESS | 2225 | Number of tests: 6 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#0] dojo.html Cycles:165 Average:5674.56 Median:5949.52 stddev:655.83 (11.0%) stddev-sans-first:623.62 19:03:35 INFO - PROCESS | 2225 | Values: 3008.9 3231.2 3375.2 3457.9 3500.5 4580.0 5527.9 5593.7 5651.4 5671.4 5581.1 5591.7 5618.6 5625.7 5630.4 5057.4 5065.7 5097.6 5141.6 5155.4 5102.4 5165.8 5166.5 5166.9 5176.2 4230.3 5115.1 5134.9 5156.2 5159.1 5137.4 5175.6 5187.7 5189.9 5259.3 5001.4 5013.0 5109.0 5149.3 5150.9 5533.1 5555.0 5557.1 5577.6 5630.1 6175.5 6181.3 6181.3 6190.0 6199.4 6073.1 6115.1 6216.8 6231.8 6248.8 5783.9 5785.6 5795.3 5829.9 5843.6 6230.3 6267.5 6274.5 6282.4 6296.3 5982.6 6018.7 6076.5 6086.5 6104.4 6190.8 6214.2 6246.9 6247.2 6251.9 6196.3 6197.9 6200.8 6203.3 6209.8 6060.8 6102.5 6144.3 6184.0 6197.2 4902.0 4905.7 4908.2 4909.7 4935.6 4411.9 4418.7 4422.5 4424.0 4470.0 5374.7 5523.3 5525.8 5539.3 5540.1 6156.9 6164.5 6260.9 6279.4 6284.1 5508.4 5510.8 5523.3 5528.9 5530.6 5237.8 5324.0 5340.7 5354.8 5355.2 5457.1 6116.7 6180.6 6238.3 6277.7 6182.4 6194.9 6200.5 6201.7 6202.7 6155.9 6204.2 6207.8 6233.7 6327.0 6100.5 6148.0 6159.0 6161.6 6178.2 6189.4 6256.2 6258.0 6260.7 6275.7 5931.6 6025.6 6102.1 6115.1 6117.0 5974.6 6032.9 6087.4 6094.7 6119.1 5940.6 5949.5 5951.5 5957.5 5966.8 5824.0 5911.1 6016.7 6090.8 6101.6 5872.5 5916.5 5969.6 5989.0 6022.5 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#1] ext.html Cycles:180 Average:61504.39 Median:39181.70 stddev:128650.80 (328.3%) stddev-sans-first:128930.03 19:03:35 INFO - PROCESS | 2225 | Values: 450.8 570.6 573.8 622.0 627.5 29526.9 37776.4 38078.8 38109.6 38142.8 41031.0 41607.0 41677.8 41723.8 41804.8 9435.0 9674.0 9692.8 9703.1 9706.0 9489.3 9651.1 9655.5 9658.5 9665.2 9020.6 9215.5 9601.7 9694.0 9800.0 9680.6 9773.5 9778.4 9783.6 9786.7 9598.7 9628.9 9634.3 9723.0 9743.6 40220.6 40513.4 40629.0 40686.0 40850.6 3196.4 3294.5 3629.0 3680.0 3807.7 28118.7 29147.0 29577.4 29761.6 29833.1 2733.2 2738.8 2770.8 2829.4 2870.8 481149.6 481826.0 483024.0 483757.0 483900.0 45267.8 45939.3 46140.3 65393.3 65786.7 45200.8 45210.4 45257.5 45427.5 45456.3 12708.0 15579.2 15631.9 15643.1 15646.9 12518.7 12592.2 12598.5 12618.7 12624.8 14793.9 14823.9 14827.0 14831.4 14947.7 6307.3 6453.8 6463.5 6477.5 6491.5 951.8 959.5 969.6 976.3 1089.7 28909.7 28964.8 29530.1 29703.6 29727.4 1053.6 1059.5 1073.6 1089.3 1132.5 11076.5 14098.4 14679.7 14883.8 14977.9 536093.0 539411.0 540183.0 541952.0 544478.0 58177.4 58512.4 59058.1 59101.0 59115.8 1334.2 1366.0 1456.3 1466.2 1493.1 24023.6 24334.6 30561.4 30820.4 30903.5 53215.7 53534.0 53818.7 54031.7 54215.7 416441.0 418258.0 418931.0 420491.0 421616.0 28050.4 29178.9 31197.8 33419.3 33638.0 41233.8 41642.0 41998.0 42026.7 42445.8 34202.3 34412.0 34563.5 35193.8 35214.8 33898.5 33991.5 34340.7 34718.5 34936.1 35466.8 35771.3 35973.8 36283.6 36619.8 31180.4 31640.0 31642.5 31723.7 31824.0 22790.0 24090.4 24281.0 24281.2 24296.6 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#2] jquery.html Cycles:180 Average:32781.30 Median:364.21 stddev:100783.96 (27672.2%) stddev-sans-first:101037.28 19:03:35 INFO - PROCESS | 2225 | Values: 362.2 363.8 364.6 374.3 375.8 15492.8 18606.0 19647.3 20051.3 20057.3 18843.2 19417.0 20198.0 20223.2 20242.1 5567.4 5771.0 5781.4 5786.2 5789.7 4118.0 4312.8 4331.5 5748.7 6272.7 5757.9 5942.8 6272.9 6280.6 6291.7 6071.6 6194.6 6269.6 6271.0 6271.6 3644.4 5143.3 5390.4 5400.4 5420.9 23781.8 23991.8 24213.6 25370.9 25382.2 2121.0 2194.1 2243.3 2276.7 2773.0 6814.3 7084.7 7572.5 13882.2 14691.7 1658.6 1703.2 1732.6 1736.1 1758.4 99936.0 102791.0 102824.0 102843.0 103221.0 9764.4 9865.9 10110.3 10133.3 10286.4 12630.1 12641.0 12671.9 12677.5 12686.5 8344.7 8364.5 8385.3 8418.6 8460.5 8637.9 8657.9 8692.3 8734.7 8745.5 4861.3 4967.3 5947.3 5963.9 5987.3 1653.8 1723.0 1730.8 1740.6 1821.7 888.9 909.5 964.0 972.9 1000.3 19517.6 20560.0 20624.9 20664.3 20875.0 990.4 999.3 1003.1 1009.7 1031.2 9262.6 10644.8 11164.2 11191.0 11321.4 530396.0 611165.0 624189.0 643076.0 643548.0 59945.7 87917.6 99863.0 100816.0 101473.0 947.1 987.9 1038.6 1058.3 1060.4 14342.4 17927.7 17970.0 18006.7 18306.6 40284.8 42467.8 42979.4 43259.1 43410.8 59127.8 60122.0 60354.8 60414.0 60456.1 7379.2 7489.3 7539.7 7667.5 7940.5 12187.4 12329.4 12410.0 12719.6 12806.6 10652.8 10737.7 10860.6 11025.4 11250.2 5178.2 9548.2 10444.3 10842.2 10876.7 11183.6 11449.8 11509.4 11555.5 11678.5 7853.1 7927.2 7984.3 8034.6 8071.6 9861.2 10862.9 11172.4 11219.5 11251.3 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#3] mootools.html Cycles:180 Average:6027.10 Median:5477.30 stddev:3202.85 (58.5%) stddev-sans-first:3193.11 19:03:35 INFO - PROCESS | 2225 | Values: 1419.4 1539.7 1578.3 1841.9 1998.2 7911.0 8598.3 8740.0 8755.9 8768.8 8499.2 8690.2 8715.5 8738.4 8746.3 2165.1 2418.0 2462.0 2477.2 2495.3 2510.0 2518.8 2519.4 2522.2 2525.8 2047.3 2402.4 2457.8 2457.9 2459.1 1979.0 2230.4 2309.2 2466.4 2470.8 2423.4 2460.9 2466.8 2469.9 2470.2 8731.3 8809.9 8839.2 8859.1 8874.0 5399.4 5576.4 5601.7 5602.2 5603.5 3572.5 3620.2 3692.2 3699.4 3705.3 1034.4 1054.6 1061.1 1063.2 1070.2 11988.4 12028.7 12041.7 12054.9 12062.5 4834.2 4887.2 4905.3 4952.7 4972.0 9975.2 9976.6 9997.4 10000.0 10027.8 5555.2 5561.1 5573.7 5577.6 5595.0 4470.9 4571.2 4858.0 4966.9 5008.3 3317.8 3845.8 3918.0 3929.8 3982.2 1296.3 1316.6 1323.0 1337.5 1339.5 1326.8 1345.3 1356.5 1373.7 1389.1 8105.9 8224.1 8246.0 8271.3 8275.6 514.3 521.4 528.7 529.0 531.7 6172.3 6181.7 6190.7 6211.0 6235.9 10352.7 10681.7 10700.1 10763.5 10809.7 10228.8 10602.3 10607.7 10660.8 10692.8 8204.0 8282.5 8302.3 8303.8 8379.1 7633.9 7852.9 7863.6 7873.7 7907.0 9189.9 9450.1 9605.7 9680.9 9720.0 9688.5 9931.0 10011.4 10033.7 10141.6 6664.2 6855.1 7311.5 7410.0 7502.3 8219.9 8231.2 8262.5 8270.6 8289.3 7231.2 7299.2 7334.5 7422.8 7431.3 7036.4 7185.5 7218.0 7229.2 7244.5 7471.4 7590.7 7597.0 7599.3 7600.8 6839.8 6877.1 6941.8 6945.0 6945.4 6965.4 6966.9 6975.1 6976.1 7005.8 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#4] prototype.html Cycles:180 Average:5709.25 Median:6452.90 stddev:1806.33 (28.0%) stddev-sans-first:1765.50 19:03:35 INFO - PROCESS | 2225 | Values: 318.5 324.8 326.3 333.7 335.6 6484.1 6498.1 6561.5 6562.1 6593.9 6410.9 6465.2 6477.9 6481.3 6500.9 4586.3 4668.0 4709.3 4816.0 4853.1 4774.4 4804.6 4805.5 4809.7 4812.8 3916.8 4771.4 4778.7 4786.8 4804.1 3815.8 4505.9 4604.2 4716.8 4724.4 4080.2 4093.0 4102.2 4103.1 4105.0 6179.3 6191.3 6192.8 6207.1 6239.7 5706.7 5710.4 5723.1 5724.6 5746.8 6923.6 6927.1 6935.1 6940.5 6947.7 4497.4 4670.8 4685.7 4695.8 4696.9 7082.5 7341.2 7350.3 7350.8 7360.1 4759.9 4773.3 4775.3 4775.7 4776.5 4034.0 4853.0 4854.6 4867.5 4872.1 5127.0 5708.5 5716.9 5724.2 5727.4 6440.5 6667.5 6953.4 6971.7 7038.1 1661.0 1670.4 1688.2 1692.3 1696.3 1030.9 1063.5 1088.1 1088.4 1118.8 6313.1 6354.0 6382.2 6387.6 6428.8 5870.3 7085.0 7295.5 7304.2 7333.7 6438.3 6442.0 6463.8 6517.0 6584.2 3808.4 3846.7 3855.2 3860.0 3866.3 7230.0 7530.5 7537.5 7562.7 7569.5 7467.1 7489.1 7514.6 7514.8 7528.7 7512.9 7535.2 7536.4 7543.2 7544.1 6923.8 7262.4 7283.6 7283.9 7285.1 6473.3 6518.5 7169.7 7175.5 7198.0 6526.6 6749.9 7489.8 7505.4 7541.2 4796.4 4804.5 4809.8 4819.7 4829.6 7213.9 7231.8 7238.2 7241.8 7251.2 6720.4 6988.9 6999.1 7058.5 7072.7 7004.7 7046.9 7047.1 7050.3 7056.7 6893.6 6903.0 6904.4 6904.8 6915.3 6789.5 7005.2 7024.0 7039.3 7046.9 5927.7 6649.9 6729.9 6822.0 6922.6 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - PROCESS | 2225 | [#5] yui.html Cycles:180 Average:18100.14 Median:65662.84 stddev:25399.28 (38.7%) stddev-sans-first:25436.90 19:03:35 INFO - PROCESS | 2225 | Values: 694.8 720.3 757.1 760.6 778.5 14731.1 14748.9 14864.9 14878.2 14885.5 13662.2 13664.9 13732.0 13739.2 13757.4 727.5 732.0 890.3 913.0 913.1 887.7 911.9 912.5 913.4 914.0 950.6 961.8 962.9 966.5 967.1 755.2 768.4 769.9 948.5 950.5 576.9 701.9 716.5 716.7 719.5 14511.0 14665.0 14680.7 14685.6 14692.3 12317.4 12354.1 12379.9 12642.4 12831.7 9620.7 9836.5 9937.0 10219.6 10285.5 3455.9 3495.2 3524.3 3542.5 3593.5 78562.0 80356.0 81702.5 82387.6 82475.6 7991.0 9530.4 9541.4 9785.0 9875.6 21582.9 21585.7 21587.1 21589.7 21642.2 6651.1 7175.5 7353.4 7539.6 7664.5 4025.3 4029.2 4037.9 4057.8 4067.7 3507.0 3539.3 3564.2 3568.7 3570.6 641.4 651.7 665.8 666.1 666.8 513.1 576.7 579.5 582.5 595.7 7733.0 8197.0 8205.6 8299.4 8314.9 568.2 578.4 580.9 604.8 617.3 3088.7 3288.9 3722.3 3762.3 3910.3 87169.1 88087.0 89832.0 90814.0 91349.0 78681.0 78866.2 79445.0 79452.4 80270.0 66526.3 66653.0 67607.3 68107.0 70628.6 7594.2 7667.2 7670.4 7882.8 7946.8 49149.0 49528.5 49573.0 50719.2 52203.0 65578.7 65747.0 65765.7 66575.0 66678.7 10875.6 11067.0 11122.6 11138.9 11193.2 11560.5 11602.5 11696.1 11817.8 11843.9 10359.5 11401.8 11498.5 11571.9 11648.8 11401.5 11499.6 11579.1 11762.8 12061.3 11229.7 11260.5 11266.6 11508.5 11522.1 9279.1 9363.2 9534.7 9556.0 9603.7 9507.0 9664.6 9693.6 9770.6 9842.8 19:03:35 INFO - PROCESS | 2225 | -------- Summary: end -------- 19:03:35 INFO - PROCESS | 2225 | 19:03:35 INFO - TEST-INFO | 2225: exit 0 19:03:35 INFO - TEST-OK | dromaeo_css | took 1113354ms 19:03:35 INFO - TEST-START | kraken 19:03:35 INFO - operating with platform_type : mac_ 19:03:35 INFO - Initialising browser for kraken test... 19:03:35 INFO - TEST-INFO | started process 2228 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp4KAVZb/profile http://localhost:51977/getInfo.html) 19:03:37 INFO - PROCESS | 2228 | __metrics Screen width/height:1600/1200 19:03:37 INFO - PROCESS | 2228 | colorDepth:24 19:03:37 INFO - PROCESS | 2228 | Browser inner width/height: 1024/689 19:03:37 INFO - PROCESS | 2228 | __metrics 19:03:38 INFO - PROCESS | 2228 | 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" 19:03:38 ERROR - PROCESS | 2228 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 19:03:38 INFO - TEST-INFO | 2228: exit 0 19:03:38 INFO - Browser initialized. 19:03:38 INFO - Running cycle 1/1 for kraken test... 19:03:38 INFO - TEST-INFO | started process 2230 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/T/tmp4KAVZb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:50 INFO - PROCESS | 2230 | RSS: Main: 236511232 19:03:50 INFO - PROCESS | 2230 | 19:03:53 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:53 INFO - PROCESS | 2230 | RSS: Main: 283000832 19:03:53 INFO - PROCESS | 2230 | 19:03:56 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-dft) 19:03:57 INFO - PROCESS | 2230 | RSS: Main: 293601280 19:03:57 INFO - PROCESS | 2230 | 19:04:00 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-fft) 19:04:01 INFO - PROCESS | 2230 | RSS: Main: 278745088 19:04:01 INFO - PROCESS | 2230 | 19:04:02 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator) 19:04:03 INFO - PROCESS | 2230 | RSS: Main: 280453120 19:04:03 INFO - PROCESS | 2230 | 19:04:05 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:04:06 INFO - PROCESS | 2230 | RSS: Main: 281378816 19:04:06 INFO - PROCESS | 2230 | 19:04:09 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom) 19:04:09 INFO - PROCESS | 2230 | RSS: Main: 282738688 19:04:09 INFO - PROCESS | 2230 | 19:04:12 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate) 19:04:13 INFO - PROCESS | 2230 | RSS: Main: 282918912 19:04:13 INFO - PROCESS | 2230 | 19:04:16 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial) 19:04:16 INFO - PROCESS | 2230 | RSS: Main: 283402240 19:04:16 INFO - PROCESS | 2230 | 19:04:18 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:04:18 INFO - PROCESS | 2230 | RSS: Main: 317865984 19:04:18 INFO - PROCESS | 2230 | 19:04:20 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:04:21 INFO - PROCESS | 2230 | RSS: Main: 317915136 19:04:21 INFO - PROCESS | 2230 | 19:04:23 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:04:24 INFO - PROCESS | 2230 | RSS: Main: 323624960 19:04:24 INFO - PROCESS | 2230 | 19:04:26 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:04:27 INFO - PROCESS | 2230 | RSS: Main: 324542464 19:04:27 INFO - PROCESS | 2230 | 19:04:29 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:04:30 INFO - PROCESS | 2230 | RSS: Main: 324739072 19:04:30 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | Cycle 1(1): loaded http://localhost:51977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51977/tests/kraken/driver.html?testName=ai-astar) 19:04:32 INFO - PROCESS | 2230 | RSS: Main: 388079616 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | __start_tp_report 19:04:32 INFO - PROCESS | 2230 | _x_x_mozilla_page_load 19:04:32 INFO - PROCESS | 2230 | _x_x_mozilla_page_load_details 19:04:32 INFO - PROCESS | 2230 | |i|pagename|runs| 19:04:32 INFO - PROCESS | 2230 | |0;ai-astar;112;109;112;110;111;112;115;109;111;111 19:04:32 INFO - PROCESS | 2230 | |1;audio-beat-detection;158;126;177;165;145;178;169;148;164;119 19:04:32 INFO - PROCESS | 2230 | |2;audio-dft;188;184;184;187;184;187;184;181;183;184 19:04:32 INFO - PROCESS | 2230 | |3;audio-fft;71;71;81;80;55;59;58;82;83;66 19:04:32 INFO - PROCESS | 2230 | |4;audio-oscillator;92;94;128;90;115;118;129;77;78;123 19:04:32 INFO - PROCESS | 2230 | |5;imaging-gaussian-blur;87;84;86;84;87;83;86;83;91;129 19:04:32 INFO - PROCESS | 2230 | |6;imaging-darkroom;94;141;92;93;92;92;92;93;92;92 19:04:32 INFO - PROCESS | 2230 | |7;imaging-desaturate;86;85;85;93;79;126;134;131;86;87 19:04:32 INFO - PROCESS | 2230 | |8;json-parse-financial;55;56;55;53;54;53;55;64;64;63 19:04:32 INFO - PROCESS | 2230 | |9;json-stringify-tinderbox;65;73;74;70;72;70;68;69;70;68 19:04:32 INFO - PROCESS | 2230 | |10;stanford-crypto-aes;84;82;83;84;86;83;84;82;97;108 19:04:32 INFO - PROCESS | 2230 | |11;stanford-crypto-ccm;121;128;138;123;136;132;135;118;131;121 19:04:32 INFO - PROCESS | 2230 | |12;stanford-crypto-pbkdf2;137;131;140;138;138;129;139;138;173;178 19:04:32 INFO - PROCESS | 2230 | |13;stanford-crypto-sha256-iterative;67;65;66;67;67;67;66;66;69;67 19:04:32 INFO - PROCESS | 2230 | __end_tp_report 19:04:32 INFO - PROCESS | 2230 | __start_cc_report 19:04:32 INFO - PROCESS | 2230 | _x_x_mozilla_cycle_collect,1315 19:04:32 INFO - PROCESS | 2230 | __end_cc_report 19:04:32 INFO - PROCESS | 2230 | __startTimestamp1459994672443__endTimestamp 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | ------- Summary: start ------- 19:04:32 INFO - PROCESS | 2230 | Number of tests: 14 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:1.75 (1.6%) stddev-sans-first:1.83 19:04:32 INFO - PROCESS | 2230 | Values: 112.0 109.0 112.0 110.0 111.0 112.0 115.0 109.0 111.0 111.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#1] audio-beat-detection Cycles:10 Average:154.90 Median:164.50 stddev:20.23 (12.3%) stddev-sans-first:21.43 19:04:32 INFO - PROCESS | 2230 | Values: 158.0 126.0 177.0 165.0 145.0 178.0 169.0 148.0 164.0 119.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#2] audio-dft Cycles:10 Average:184.60 Median:184.00 stddev:2.12 (1.2%) stddev-sans-first:1.86 19:04:32 INFO - PROCESS | 2230 | Values: 188.0 184.0 184.0 187.0 184.0 187.0 184.0 181.0 183.0 184.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#3] audio-fft Cycles:10 Average:70.60 Median:75.50 stddev:10.74 (14.2%) stddev-sans-first:11.39 19:04:32 INFO - PROCESS | 2230 | Values: 71.0 71.0 81.0 80.0 55.0 59.0 58.0 82.0 83.0 66.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:77.50 stddev:20.34 (26.2%) stddev-sans-first:21.07 19:04:32 INFO - PROCESS | 2230 | Values: 92.0 94.0 128.0 90.0 115.0 118.0 129.0 77.0 78.0 123.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:86.00 stddev:13.91 (16.2%) stddev-sans-first:14.71 19:04:32 INFO - PROCESS | 2230 | Values: 87.0 84.0 86.0 84.0 87.0 83.0 86.0 83.0 91.0 129.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:92.00 stddev:15.37 (16.7%) stddev-sans-first:16.26 19:04:32 INFO - PROCESS | 2230 | Values: 94.0 141.0 92.0 93.0 92.0 92.0 92.0 93.0 92.0 92.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#7] imaging-desaturate Cycles:10 Average:99.20 Median:85.50 stddev:21.83 (25.5%) stddev-sans-first:22.62 19:04:32 INFO - PROCESS | 2230 | Values: 86.0 85.0 85.0 93.0 79.0 126.0 134.0 131.0 86.0 87.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:55.50 stddev:4.57 (8.2%) stddev-sans-first:4.77 19:04:32 INFO - PROCESS | 2230 | Values: 55.0 56.0 55.0 53.0 54.0 53.0 55.0 64.0 64.0 63.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:2.64 (3.8%) stddev-sans-first:2.13 19:04:32 INFO - PROCESS | 2230 | Values: 65.0 73.0 74.0 70.0 72.0 70.0 68.0 69.0 70.0 68.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:84.00 stddev:8.50 (10.1%) stddev-sans-first:8.93 19:04:32 INFO - PROCESS | 2230 | Values: 84.0 82.0 83.0 84.0 86.0 83.0 84.0 82.0 97.0 108.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:131.50 stddev:7.15 (5.4%) stddev-sans-first:7.08 19:04:32 INFO - PROCESS | 2230 | Values: 121.0 128.0 138.0 123.0 136.0 132.0 135.0 118.0 131.0 121.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.10 Median:138.50 stddev:16.96 (12.2%) stddev-sans-first:17.79 19:04:32 INFO - PROCESS | 2230 | Values: 137.0 131.0 140.0 138.0 138.0 129.0 139.0 138.0 173.0 178.0 19:04:32 INFO - PROCESS | 2230 | 19:04:32 INFO - PROCESS | 2230 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 19:04:32 INFO - PROCESS | 2230 | Values: 67.0 65.0 66.0 67.0 67.0 67.0 66.0 66.0 69.0 67.0 19:04:32 INFO - PROCESS | 2230 | -------- Summary: end -------- 19:04:32 INFO - PROCESS | 2230 | 19:04:33 INFO - TEST-INFO | 2230: exit 0 19:04:33 INFO - TEST-OK | kraken | took 57470ms 19:04:33 INFO - SUITE-END | took 1170s 19:04:33 INFO - Completed test suite (00:19:31) 19:04:33 INFO - javascript benchmark 19:04:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3008.924776880579, 3231.208353953282, 3375.2405708715532, 3457.8616855325795, 3500.5274287971115, 4579.977100114499, 5527.917081243784, 5593.692346920918, 5651.434856514346, 5671.376148623648, 5581.134924086763, 5591.664500129995, 5618.550515958724, 5625.6905870177225, 5630.352509461413, 5057.393112826466, 5065.696058236499, 5097.617678674096, 5141.562967147797, 5155.407128180251, 5102.413222479426, 5165.76754046067, 5166.535011848933, 5166.9224961625605, 5176.223566465042, 4230.259704551707, 5115.079285728568, 5134.948650513503, 5156.175011998081, 5159.071367153911, 5137.434882162959, 5175.637705360627, 5187.714675692835, 5189.896202075937, 5259.26370308159, 5001.374828146481, 5013.0, 5109.0, 5149.2791009258735, 5150.948490515084, 5533.059379905426, 5555.027870122713, 5557.138643510262, 5577.553795696334, 5630.09918413056, 6175.475084617813, 6181.258249010102, 6181.289151747562, 6189.978653522164, 6199.442050215457, 6073.089036644495, 6115.143879856823, 6216.813495595139, 6231.750729970796, 6248.812535623939, 5783.8554036149435, 5785.5660825437835, 5795.275590551181, 5829.912551311733, 5843.561732869966, 6230.302788526701, 6267.5299352548745, 6274.466670332981, 6282.415886203838, 6296.338884417162, 5982.581219314693, 6018.668973206516, 6076.513878889678, 6086.482648974798, 6104.38956104386, 6190.8230152949245, 6214.223222097238, 6246.875062498724, 6247.187865577446, 6251.906221406592, 6196.256449226122, 6197.876042479125, 6200.81397558074, 6203.348648391854, 6209.813705588839, 6060.848478788065, 6102.481289090389, 6144.279601711528, 6183.979643358885, 6197.163382943335, 4901.975490122527, 4905.7301848397965, 4908.239222920453, 4909.729964851967, 4935.580475659537, 4411.889702757457, 4418.668599855024, 4422.513523512411, 4424.0, 4470.0, 5374.704391258519, 5523.309586301712, 5525.751341189656, 5539.307586551681, 5540.058190107691, 6156.938430615636, 6164.537659675452, 6260.937390626035, 6279.372062793684, 6284.057391391328, 5508.421615730371, 5510.834674959758, 5523.337199536001, 5528.917066244009, 5530.6128570999645, 5237.764300606482, 5323.973380133075, 5340.652857564246, 5354.839354819362, 5355.196720491957, 5457.072297709319, 6116.66358350295, 6180.6291622502795, 6238.251409830758, 6277.686115694106, 6182.350853160354, 6194.907076393948, 6200.503959683305, 6201.720922558406, 6202.7208775606105, 6155.907661385172, 6204.193454850841, 6207.782727604512, 6233.657148856856, 6326.9683651581445, 6100.511959043177, 6147.96926015385, 6159.045347971071, 6161.599496032743, 6178.227721534809, 6189.412005859436, 6256.186695729526, 6258.030005349178, 6260.718267678057, 6275.6548389839, 5931.555133364928, 6025.608335458356, 6102.084687296941, 6115.143879856734, 6117.021276595723, 5974.581779275409, 6032.883916475466, 6087.421694938974, 6094.695265236809, 6119.051547010221, 5940.584159108821, 5949.524038076857, 5951.464368206882, 5957.523398128226, 5966.791162309299, 5824.0, 5911.142884281841, 6016.7292471838, 6090.817275481742, 6101.633901965896, 5872.500837428695, 5916.467517923407, 5969.641821490724, 5989.0, 6022.48808851235], "unit": "score", "name": "dojo.html", "value": 5631.624252276667}, {"lowerIsBetter": false, "replicates": [450.7768654516015, 570.640496487213, 573.810642487979, 621.9813405597831, 627.5450298533564, 29526.852365738167, 37776.433353499684, 38078.809605952, 38109.61890381092, 38142.8092859536, 41031.0, 41607.0, 41677.791611041976, 41723.791381043055, 41804.79097604515, 9435.0, 9674.0, 9692.75768105796, 9703.126718595326, 9706.0, 9489.335746497747, 9651.083147101013, 9655.46894920779, 9658.517074146299, 9665.226781857435, 9020.594073266719, 9215.493147876865, 9601.711948641552, 9693.951530242339, 9799.95100024499, 9680.564374603124, 9773.51132443382, 9778.41329520231, 9783.608655653765, 9786.706398808046, 9598.712038638781, 9628.855567166498, 9634.325597208199, 9722.951385243028, 9743.61025558984, 40220.59779402227, 40513.392299115534, 40629.0, 40686.0, 40850.591494084976, 3196.408664397094, 3294.456414691597, 3628.963710362889, 3679.9880032990873, 3807.733458657895, 28118.718812811814, 29147.0, 29577.408451830845, 29761.553576696366, 29833.10500684983, 2733.1937078561873, 2738.753512183913, 2770.7644850187758, 2829.3775369418695, 2870.8277503349864, 481149.59425203, 481826.0, 483024.0, 483757.0, 483900.0, 45267.77366113148, 45939.310910336375, 46140.30789538159, 65393.34606653968, 65786.67106664531, 45200.77399612981, 45210.38316934637, 45257.54742452599, 45427.54572454299, 45456.318155227695, 12708.046896482801, 15579.221038948008, 15631.921840390725, 15643.139627320379, 15646.921765391327, 12518.74962500745, 12592.181508201938, 12598.496060157675, 12618.684532886567, 12624.81062784059, 14793.92603036978, 14823.925880370529, 14827.0, 14831.40674373013, 14947.70104597902, 6307.26550198699, 6453.838654033687, 6463.450606698483, 6477.5465717400275, 6491.51313651478, 951.8143961927497, 959.5250351076122, 969.6170012844887, 976.3360914578155, 1089.6622047165404, 28909.71090289112, 28964.84140634393, 29530.114096577137, 29703.554446683316, 29727.40545189084, 1053.5733028123623, 1059.5496913811598, 1073.5652060915343, 1089.2593036734938, 1132.5073592987078, 11076.501557429934, 14098.365573549216, 14679.706405871822, 14883.846165352808, 14977.925110374379, 536093.0, 539411.0, 540183.0, 541952.0, 544478.0, 58177.4182258172, 58512.4148758507, 59058.11412828811, 59101.0, 59115.81768364694, 1334.1861464506644, 1365.9795103073661, 1456.3228098934046, 1466.1789397937189, 1493.059372595258, 24023.621656493753, 24334.63498047495, 30561.388772224876, 30820.383592328475, 30903.536446953764, 53215.669608260105, 53534.0, 53818.73090634522, 54031.72984135054, 54215.72892135514, 416441.0, 418258.0, 418931.0, 420491.0, 421616.0, 28050.438991220468, 29178.854105729337, 31197.8440107798, 33419.331613368086, 33638.0, 41233.79383103185, 41642.0, 41997.95005124896, 42026.739197824114, 42445.78777106095, 34202.31595368029, 34412.0, 34563.48154777731, 35193.82403087968, 35214.82392588123, 33898.49152262669, 33991.4901276486, 34340.656593434745, 34718.47922281118, 34936.12659683528, 35466.822665887536, 35771.28457430889, 35973.82013089918, 36283.637163628024, 36619.81690091533, 31180.376392472477, 31639.985628169048, 31642.525362119126, 31723.682763172073, 31824.04527864168, 22790.0, 24090.39774005664, 24281.028758849447, 24281.150159744324, 24296.635550467112], "unit": "score", "name": "ext.html", "value": 18927.336233844886}, {"lowerIsBetter": false, "replicates": [362.23929747530184, 363.77082438063997, 364.6426502028012, 374.305662995144, 375.84214629855455, 15492.838037147218, 18606.0, 19647.31234406796, 20051.29820456284, 20057.29799457019, 18843.24627014918, 19417.0, 20198.0, 20223.191072357087, 20242.089105990228, 5567.387587365387, 5771.0, 5781.421857814227, 5786.1610066540325, 5789.710514474281, 4117.958820411787, 4312.762798046107, 4331.501877284106, 5748.741306641211, 6272.68636568172, 5757.942420575782, 5942.781729745413, 6272.937270627281, 6280.623162610258, 6291.653959032252, 6071.574989750719, 6194.628322300677, 6269.592476489036, 6270.968645156745, 6271.5923464975085, 3644.398674218751, 5143.305653736735, 5390.353157621111, 5400.432954539756, 5420.864478388033, 23781.7621823783, 23991.7600823993, 24213.636795447906, 25370.873145634338, 25382.238532844043, 2120.97132890548, 2194.1004188282727, 2243.304575581575, 2276.6926464927187, 2772.987859431313, 6814.250432452426, 7084.716611335541, 7572.469927105105, 13882.167069975732, 14691.706165876729, 1658.552190908448, 1703.2335449047978, 1732.610162713392, 1736.114581563399, 1758.4109323376556, 99936.0, 102791.0, 102824.0, 102843.0, 103221.0, 9764.365316254563, 9865.901340986642, 10110.342827716322, 10133.290669653054, 10286.382817031003, 12630.115891887663, 12641.0, 12671.873281267253, 12677.492900284069, 12686.49254029847, 8344.707935222237, 8364.539950302791, 8385.287250583646, 8418.621162047722, 8460.492370457792, 8637.870431943526, 8657.913420865836, 8692.261157801659, 8734.650613975497, 8745.47527148373, 4861.347141971746, 4967.304577359173, 5947.256592925884, 5963.890276287317, 5987.251593550806, 1653.8180800111977, 1722.9913850430667, 1730.7749992500894, 1740.634466761969, 1821.6629923463936, 888.9333300002526, 909.5406819556082, 963.9759006024906, 972.9027097290215, 1000.3347773730388, 19517.609647806963, 20560.0, 20624.896875515526, 20664.276750313667, 20875.0, 990.4354517924858, 999.2954966748425, 1003.087190656499, 1009.7223263602568, 1031.2471895516314, 9262.583183756613, 10644.840327395095, 11164.162687798447, 11190.992810646918, 11321.433928303552, 530396.0, 611165.0, 624189.0, 643076.0, 643548.0, 59945.70027149836, 87917.56041219753, 99863.00136998683, 100815.9573883374, 101473.0, 947.1144479911305, 987.8616993620899, 1038.6364772329623, 1058.3491152940885, 1060.4379678770265, 14342.354594043085, 17927.73108403401, 17970.011649358887, 18006.72989905179, 18306.633867322846, 40284.798576006935, 42467.7876610615, 42979.355309671, 43259.134817302845, 43410.78294608507, 59127.81744365003, 60122.0, 60354.79290414255, 60414.0, 60456.09315860354, 7379.2251813558805, 7489.28851759082, 7539.660715267936, 7667.501612395176, 7940.483868548526, 12187.390630468264, 12329.383530823603, 12410.0, 12719.55481558141, 12806.61580152597, 10652.84020739674, 10737.677869663923, 10860.565577376816, 11025.44872756375, 11250.212485125963, 5178.249153872743, 9548.236141108833, 10444.321119127233, 10842.241043126905, 10876.673699789018, 11183.608573699881, 11449.771004580029, 11509.424528773361, 11555.480003400035, 11678.532858685898, 7853.1361550228285, 7927.167647397171, 7984.321332686554, 8034.638441270274, 8071.556064416279, 9861.211103111877, 10862.945685271523, 11172.441377931233, 11219.495122719334, 11251.268667536584], "unit": "score", "name": "jquery.html", "value": 9097.151480401379}, {"lowerIsBetter": false, "replicates": [1419.4393214680194, 1539.699758547083, 1578.2897696036782, 1841.8894866308021, 1998.2406685459523, 7910.982699411649, 8598.312135029199, 8739.956300218506, 8755.868661970075, 8768.780780480483, 8499.235068843804, 8690.17443342883, 8715.520646364448, 8738.388312818106, 8746.300295976322, 2165.133946421436, 2417.987910060447, 2461.9753802462014, 2477.2196758021164, 2495.3137887081107, 2510.0336370497307, 2518.7733104020635, 2519.370157460635, 2522.1802914052914, 2525.7979361651114, 2047.2834507922257, 2402.411409204747, 2457.778799908008, 2457.9262622121364, 2459.102427613926, 1979.0, 2230.353197572702, 2309.214866945238, 2466.3957330454155, 2470.8146888983397, 2423.4183795889035, 2460.938476538083, 2466.77798998091, 2469.8888550015295, 2470.2465747946867, 8731.345149113842, 8809.86785198216, 8839.204471597523, 8859.114088591154, 8874.0, 5399.37907140676, 5576.386597474275, 5601.663900165962, 5602.24369710088, 5603.467670571289, 3572.464130380438, 3620.2216523447587, 3692.1692619160744, 3699.445083237509, 3705.277470893177, 1034.4155552113032, 1054.5781687325054, 1061.103367654331, 1063.2079101069676, 1070.2401295080424, 11988.400579971054, 12028.69928251792, 12041.698957526045, 12054.879451205376, 12062.517499300018, 4834.154023045953, 4887.193613053877, 4905.264210368473, 4952.653314268039, 4971.950280497221, 9975.152112070411, 9976.551055202533, 9997.400155990665, 10000.0, 10027.849582256125, 5555.2222688823595, 5561.082421400504, 5573.721313934287, 5577.637453565587, 5595.048841696921, 4470.888227794266, 4571.154336447701, 4857.975710121497, 4966.850994470172, 5008.323876276656, 3317.8102452381313, 3845.7884816335372, 3918.0, 3929.842806287774, 3982.203559288154, 1296.3194322980323, 1316.5918565244804, 1322.966925826862, 1337.525178561616, 1339.4575197045017, 1326.8275124233787, 1345.3206130903832, 1356.4506374918174, 1373.6771858613217, 1389.0554422992461, 8105.878411823827, 8224.136465671018, 8246.0, 8271.296939760068, 8275.586220688941, 514.3133916221811, 521.3717470448101, 528.7065678548443, 528.9814856480082, 531.6544246239897, 6172.290186628506, 6181.660008699565, 6190.659513726699, 6210.975189093749, 6235.906461403082, 10352.689419317432, 10681.732956675989, 10700.090492308085, 10763.46182690878, 10809.67570972872, 10228.846567301496, 10602.25784195099, 10607.681769546925, 10660.786784264272, 10692.839607405895, 8203.958980205061, 8282.461639993382, 8302.335813135056, 8303.750887473385, 8379.078301386964, 7633.885491717518, 7852.882206767017, 7863.646135924012, 7873.724419645285, 7906.960465197637, 9189.908100918905, 9450.102240287162, 9605.711828645151, 9680.854787178057, 9719.951400242953, 9688.515574221401, 9931.0, 10011.449370284414, 10033.749156271151, 10141.594336226468, 6664.233613134552, 6855.108835851307, 7311.524750891388, 7410.036695229585, 7502.287282708134, 8219.917800821915, 8231.176882311722, 8262.462939908886, 8270.586470676562, 8289.33685305162, 7231.204567497466, 7299.233580474186, 7334.486585939147, 7422.8144296390865, 7431.256874312526, 7036.366726994595, 7185.461090418135, 7217.963910180415, 7229.192701824544, 7244.492885497964, 7471.439642026761, 7590.734324298623, 7596.962015189889, 7599.316061554266, 7600.771976840703, 6839.829004274734, 6877.071595334566, 6941.75703850383, 6945.0, 6945.409640180641, 6965.407940325129, 6966.895496567657, 6975.128108986377, 6976.127984002, 7005.789826305219], "unit": "score", "name": "mootools.html", "value": 4834.002391892764}, {"lowerIsBetter": false, "replicates": [318.5397101188783, 324.78726434185614, 326.2528809027327, 333.70133730311386, 335.58220016079986, 6484.092227088206, 6498.090267362567, 6561.475081993435, 6562.081308616797, 6593.901091483632, 6410.903836442445, 6465.191851018622, 6477.90283145752, 6481.31946145655, 6500.902486462707, 4586.289125185602, 4668.0, 4709.270063140219, 4816.0, 4853.08814711174, 4774.379330687006, 4804.5916097131785, 4805.471398146201, 4809.735464549466, 4812.759362031902, 3916.843326266946, 4771.42742870856, 4778.665493415462, 4786.83246086387, 4804.1352556539805, 3815.828287727059, 4505.932411013838, 4604.240300350421, 4716.834910778106, 4724.362211101492, 4080.163926233207, 4092.9795351023054, 4102.200070986159, 4103.056297051665, 4104.958950410517, 6179.258488981306, 6191.288001879797, 6192.845178870519, 6207.099970504297, 6239.688015599248, 5706.71466426677, 5710.428957104298, 5723.141528770676, 5724.627899186539, 5746.770129194827, 6923.619200943946, 6927.134108236471, 6935.133108361455, 6940.514164008521, 6947.652617369162, 4497.415336006331, 4670.813167473297, 4685.718856868599, 4695.835645752416, 4696.859094227145, 7082.504224704273, 7341.229170937028, 7350.301721336465, 7350.816229594249, 7360.116785985716, 4759.857204283877, 4773.331733557305, 4775.331453596499, 4775.689580177277, 4776.450708168536, 4033.9596604034173, 4853.02939412119, 4854.635902307341, 4867.5132486751045, 4872.098661747517, 5126.974365128151, 5708.4862362387585, 5716.885662286731, 5724.198612194296, 5727.39862314451, 6440.516961227927, 6667.499937504706, 6953.4089602384365, 6971.721131154697, 7038.085048943604, 1660.9501714948572, 1670.4320531019512, 1688.2318545061967, 1692.2723229011397, 1696.3129932377408, 1030.855680204772, 1063.4788953412772, 1088.080571916729, 1088.4394536813547, 1118.798616249083, 6313.116163737081, 6354.046892965999, 6382.234131904202, 6387.584806987531, 6428.774992875227, 5870.3249126350165, 7084.9726789615215, 7295.489315747953, 7304.196538380774, 7333.669984850588, 6438.291787903327, 6441.967790161113, 6463.838404039937, 6517.0, 6584.242812076673, 3808.447775072599, 3846.7114966377635, 3855.1711382052995, 3860.0, 3866.2654095721723, 7230.0, 7530.472866899374, 7537.472376933562, 7562.697492100255, 7569.5079819811535, 7467.141278752904, 7489.063867016623, 7514.586697731568, 7514.812129696801, 7528.698852045966, 7512.8873066905135, 7535.246475352531, 7536.359409450258, 7543.207963163899, 7544.0569928758905, 6923.792286231421, 7262.419006479363, 7283.635818209174, 7283.854322913406, 7285.089363829521, 6473.255575608865, 6518.543701941008, 7169.749058783126, 7175.497715160098, 7198.0, 6526.608403495806, 6749.93250067493, 7489.812754681177, 7505.399568034435, 7541.170471248268, 4796.37647105874, 4804.453639571033, 4809.807607695793, 4819.734914579732, 4829.613630909589, 7213.855722885618, 7231.819204519929, 7238.23998480173, 7241.818954525968, 7251.23861994483, 6720.361565651256, 6988.895166572607, 6999.09011828459, 7058.505904586629, 7072.71709131629, 7004.704129736015, 7046.894296585658, 7047.119110111236, 7050.294970502909, 7056.682449289691, 6893.620850853251, 6903.0335752995625, 6904.447644188353, 6904.792856214322, 6915.308469153246, 6789.490788191004, 7005.159380874327, 7023.964880175567, 7039.296070392919, 7046.859062818612, 5927.733252003756, 6649.900251496135, 6729.865402692017, 6821.965890170517, 6922.550034247758], "unit": "score", "name": "prototype.html", "value": 5108.338483784945}, {"lowerIsBetter": false, "replicates": [694.8401867570459, 720.2761224968906, 757.1330826203997, 760.6424980259278, 778.5250996891898, 14731.116133032012, 14748.852511474883, 14864.925675371634, 14878.181700006482, 14885.479008234714, 13662.180269183857, 13664.863351366483, 13732.038757286993, 13739.17564946104, 13757.380917858696, 727.4834867244263, 732.0337154955461, 890.3366991591257, 912.9908700912972, 913.137085454246, 887.6538150121457, 911.8677791720197, 912.4935660708304, 913.3834661603424, 913.9908600913973, 950.5532399772096, 961.8316794560924, 962.903709629035, 966.50708138849, 967.0764419978904, 755.2447552447552, 768.4160038370878, 769.8922150898878, 948.4972964328916, 950.538988590533, 576.8759716660896, 701.9087518622597, 716.5485743981259, 716.7168968257561, 719.4999475364624, 14510.984231103826, 14665.04677195979, 14680.706385872223, 14685.632859178499, 14692.26538673062, 12317.384130793514, 12354.135210535265, 12379.876201237963, 12642.431090600945, 12831.679208019781, 9620.71137865865, 9836.508174591241, 9937.0, 10219.591216351337, 10285.485725713685, 3455.94816077759, 3495.1611613212644, 3524.3303772283184, 3542.468629705539, 3593.4969104325414, 78562.0, 80356.0, 81702.54892353299, 82387.5880620599, 82475.5876220621, 7991.0, 9530.428174309563, 9541.379810312308, 9785.021497850157, 9875.60497580103, 21582.89208553947, 21585.67621485679, 21587.136514539558, 21589.67615485769, 21642.24252151167, 6651.102101216274, 7175.461840361993, 7353.419014911819, 7539.623018849035, 7664.501807382502, 4025.2955732747237, 4029.1538776857187, 4037.8990525237105, 4057.797110144481, 4067.6949228807957, 3507.000504856104, 3539.3275277697153, 3564.2336897567147, 3568.6966607838103, 3570.589382221026, 641.3586413586413, 651.6611362091686, 665.7736369634348, 666.0641798273336, 666.7832954289876, 513.0662194805418, 576.7058800012024, 579.5305802300151, 582.528152196722, 595.7319206357157, 7733.0, 8196.959015204886, 8205.58972051395, 8299.385693506527, 8314.916850831414, 568.2186992884783, 578.4475825586554, 580.8896309701228, 604.7671646416073, 617.2685367839125, 3088.675689052662, 3288.901332960015, 3722.2555488902326, 3762.3227818992295, 3910.276598829226, 87169.12830871737, 88087.0, 89832.0, 90814.0, 91349.0, 78681.0, 78866.21133788589, 79445.0, 79452.4109517818, 80270.0, 66526.33473665202, 66653.0, 67607.3239267601, 68107.0, 70628.6468567654, 7594.164641889498, 7667.194944530744, 7670.42471814605, 7882.84234315299, 7946.7615971520945, 49149.017019660125, 49528.50471495239, 49573.0, 50719.2392114126, 52203.0, 65578.68842623025, 65747.0, 65765.68468630697, 66575.0, 66678.66660666665, 10875.564977401133, 11067.0, 11122.555097796321, 11138.888611113785, 11193.160512961724, 11560.544736672482, 11602.535898563963, 11696.06431485496, 11817.763644726885, 11843.940780296043, 10359.482025898524, 11401.828972565252, 11498.540058397904, 11571.884281157081, 11648.76702465929, 11401.486933087865, 11499.597514086967, 11579.131565132817, 11762.82355764647, 12061.336626485627, 11229.719257018312, 11260.493277802683, 11266.605668801552, 11508.48211830453, 11522.078233741113, 9279.072092790668, 9363.204127648954, 9534.659277463195, 9555.952220238854, 9603.663871764455, 9507.0, 9664.613415463584, 9693.6122555097, 9770.560324785543, 9842.832195586636], "unit": "score", "name": "yui.html", "value": 6812.086906966304}], "name": "dromaeo_css", "value": 7391.8792674632405}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 112.0, 110.0, 111.0, 112.0, 115.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 177.0, 165.0, 145.0, 178.0, 169.0, 148.0, 164.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 154.9}, {"lowerIsBetter": true, "replicates": [188.0, 184.0, 184.0, 187.0, 184.0, 187.0, 184.0, 181.0, 183.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 81.0, 80.0, 55.0, 59.0, 58.0, 82.0, 83.0, 66.0], "unit": "score", "name": "audio-fft", "value": 70.6}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 128.0, 90.0, 115.0, 118.0, 129.0, 77.0, 78.0, 123.0], "unit": "score", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 91.0, 129.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [94.0, 141.0, 92.0, 93.0, 92.0, 92.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 97.3}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 93.0, 79.0, 126.0, 134.0, 131.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 99.2}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 53.0, 54.0, 53.0, 55.0, 64.0, 64.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [65.0, 73.0, 74.0, 70.0, 72.0, 70.0, 68.0, 69.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 83.0, 84.0, 86.0, 83.0, 84.0, 82.0, 97.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.3}, {"lowerIsBetter": true, "replicates": [121.0, 128.0, 138.0, 123.0, 136.0, 132.0, 135.0, 118.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.3}, {"lowerIsBetter": true, "replicates": [137.0, 131.0, 140.0, 138.0, 138.0, 129.0, 139.0, 138.0, 173.0, 178.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.1}, {"lowerIsBetter": true, "replicates": [67.0, 65.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1465.7}]} 19:04:33 INFO - Return code: 0 19:04:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:04:33 ERROR - # TBPL SUCCESS # 19:04:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:04:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:04:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:04:33 INFO - 2016-04-06 19:04:33.766 screenresolution[2234:18379] starting screenresolution argv=screenresolution get 19:04:33 INFO - 2016-04-06 19:04:33.769 screenresolution[2234:18379] Display 0: 1600x1200x32@60 19:04:33 INFO - 2016-04-06 19:04:33.775 screenresolution[2235:18383] starting screenresolution argv=screenresolution list 19:04:33 INFO - Available Modes on Display 0 19:04:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:04:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:04:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:04:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:04:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:04:34 INFO - Intel Iris: 19:04:34 INFO - Chipset Model: Intel Iris 19:04:34 INFO - Type: GPU 19:04:34 INFO - Bus: Built-In 19:04:34 INFO - VRAM (Dynamic, Max): 1536 MB 19:04:34 INFO - Vendor: Intel (0x8086) 19:04:34 INFO - Device ID: 0x0a2e 19:04:34 INFO - Revision ID: 0x0009 19:04:34 INFO - Displays: 19:04:34 INFO - Display: 19:04:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:04:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:04:34 INFO - Display Serial Number: 1600x1200 60 19:04:34 INFO - Main Display: Yes 19:04:34 INFO - Mirror: Off 19:04:34 INFO - Online: Yes 19:04:34 INFO - Rotation: Supported 19:04:34 INFO - Return code: 0 19:04:34 INFO - Running post-action listener: _resource_record_post_action 19:04:34 INFO - Running post-run listener: _resource_record_post_run 19:04:35 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 311296; Write bytes: 695410176; Read time: 5; Write time: 2248 19:04:35 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 390023680; Write bytes: 386074112; Read time: 28600; Write time: 878 19:04:35 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 311296; Write bytes: 298158080; Read time: 5; Write time: 1338 19:04:35 INFO - Running post-run listener: _upload_blobber_files 19:04:35 INFO - Blob upload gear active. 19:04:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:04:35 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 19:04:35 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'] 19:04:35 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 19:04:35 INFO - (blobuploader) - INFO - Open directory for files ... 19:04:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:04:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:04:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:36 INFO - (blobuploader) - INFO - Done attempting. 19:04:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:04:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:04:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:04:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:04:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:04:37 INFO - (blobuploader) - INFO - Done attempting. 19:04:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:04:37 INFO - Return code: 0 19:04:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:04:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:04:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e38e95b6c97c22d1d5a677a9f1417319b9a24c39645be38e05083a2c241baa99fd6fd6ec4925b9d9f06620f5f1eaed06e168188fa9b0ce8dbde3b7ce37d5bbfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10abf4c48622a0bcc162a0e002502902e84533820d570afb864f40fa1a56480014f5c8c5a6392a270f9cabc999773fe723ea64eac6a1caf3be35b97b83a05604"} 19:04:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:04:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:04:37 INFO - Contents: 19:04:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e38e95b6c97c22d1d5a677a9f1417319b9a24c39645be38e05083a2c241baa99fd6fd6ec4925b9d9f06620f5f1eaed06e168188fa9b0ce8dbde3b7ce37d5bbfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10abf4c48622a0bcc162a0e002502902e84533820d570afb864f40fa1a56480014f5c8c5a6392a270f9cabc999773fe723ea64eac6a1caf3be35b97b83a05604"} 19:04:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:04:37 INFO - Copying logs to upload dir... 19:04:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:04:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.705037 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-06 19:04:37.416627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 19:04:37.424097) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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/e38e95b6c97c22d1d5a677a9f1417319b9a24c39645be38e05083a2c241baa99fd6fd6ec4925b9d9f06620f5f1eaed06e168188fa9b0ce8dbde3b7ce37d5bbfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10abf4c48622a0bcc162a0e002502902e84533820d570afb864f40fa1a56480014f5c8c5a6392a270f9cabc999773fe723ea64eac6a1caf3be35b97b83a05604"} build_url:https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011020 build_url: 'https://queue.taskcluster.net/v1/task/avzfxSmHQrivZDeJrWwM2Q/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/e38e95b6c97c22d1d5a677a9f1417319b9a24c39645be38e05083a2c241baa99fd6fd6ec4925b9d9f06620f5f1eaed06e168188fa9b0ce8dbde3b7ce37d5bbfc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/10abf4c48622a0bcc162a0e002502902e84533820d570afb864f40fa1a56480014f5c8c5a6392a270f9cabc999773fe723ea64eac6a1caf3be35b97b83a05604"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 19:04:37.450550) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 19:04:37.453868) ========= 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.0jbSYLByzd/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.jSsy0H3SYa/Listeners TMPDIR=/var/folders/np/2bpcjmvx1d95p6tb9r0jqkj400000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 19:04:37.502178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 19:04:37.502466) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 19:04:37.505833) ========= ========= Total master_lag: 4.88 =========