builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1458940776.65 results: success (0) buildid: 20160325131743 builduid: 2b08a6e5539b464eb85b2e8cf0eab456 revision: 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 14:19:36.652351) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 14:19:36.652726) ========= ========= Started set props: basedir (results: 0, elapsed: 5 secs) (at 2016-03-25 14:19:36.653004) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005424 basedir: '/builds/slave/test' ========= master_lag: 5.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 5 secs) (at 2016-03-25 14:19:41.857378) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-03-25 14:19:41.857664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 23 secs) (at 2016-03-25 14:20:05.389668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-25 14:20:05.390008) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005848 ========= master_lag: 7.80 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-25 14:20:13.193868) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 14:20:13.194212) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 14:20:13.194576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-25 14:20:13.194845) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-25 14:20:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-03-25 14:20:14 (46.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.476016 ========= master_lag: 3.59 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-03-25 14:20:17.264893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-25 14:20:17.265167) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.029928 ========= master_lag: 2.65 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-25 14:20:19.945348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-25 14:20:19.945703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 --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 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-25 14:20:20,447 truncating revision to first 12 chars 2016-03-25 14:20:20,447 Setting DEBUG logging. 2016-03-25 14:20:20,447 attempt 1/10 2016-03-25 14:20:20,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2bac6e929e8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 14:20:21,507 unpacking tar archive at: fx-team-2bac6e929e8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.311668 ========= master_lag: 5.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-25 14:20:26.539082) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 7 secs) (at 2016-03-25 14:20:26.539382) ========= echo 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'2bac6e929e8f4edcef0a17cbe8c38d29381e0207'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 program finished with exit code 0 elapsedTime=0.005892 script_repo_revision: '2bac6e929e8f4edcef0a17cbe8c38d29381e0207' ========= master_lag: 7.88 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 7 secs) (at 2016-03-25 14:20:34.420363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-03-25 14:20:34.420662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 25 secs) (at 2016-03-25 14:20:59.433893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-25 14:20:59.434145) ========= /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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:20:59 INFO - MultiFileLogger online at 20160325 14:20:59 in /builds/slave/test 14:20:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:20:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:20:59 INFO - {'append_to_log': False, 14:20:59 INFO - 'base_work_dir': '/builds/slave/test', 14:20:59 INFO - 'blob_upload_branch': 'Fx-Team', 14:20:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:20:59 INFO - 'branch': 'Fx-Team', 14:20:59 INFO - 'buildbot_json_path': 'buildprops.json', 14:20:59 INFO - 'config_files': ('talos/mac_config.py',), 14:20:59 INFO - 'default_actions': ('clobber', 14:20:59 INFO - 'read-buildbot-config', 14:20:59 INFO - 'download-and-extract', 14:20:59 INFO - 'populate-webroot', 14:20:59 INFO - 'create-virtualenv', 14:20:59 INFO - 'install', 14:20:59 INFO - 'run-tests'), 14:20:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:20:59 INFO - 'download_minidump_stackwalk': True, 14:20:59 INFO - 'download_symbols': 'ondemand', 14:20:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:20:59 INFO - 'tooltool.py': '/tools/tooltool.py', 14:20:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:20:59 INFO - '/tools/misc-python/virtualenv.py')}, 14:20:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:20:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:20:59 INFO - 'installer_path': 'installer.exe', 14:20:59 INFO - 'log_level': 'info', 14:20:59 INFO - 'log_name': 'talos', 14:20:59 INFO - 'log_to_console': True, 14:20:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:20:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:20:59 INFO - 'opt_config_files': (), 14:20:59 INFO - 'pip_index': False, 14:20:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:59 INFO - 'cmd': ('bash', 14:20:59 INFO - '-c', 14:20:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:59 INFO - 'enabled': True, 14:20:59 INFO - 'halt_on_failure': False, 14:20:59 INFO - 'name': 'check_screen_resolution'},), 14:20:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:59 INFO - 'cmd': ('bash', 14:20:59 INFO - '-c', 14:20:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:59 INFO - 'enabled': True, 14:20:59 INFO - 'halt_on_failure': False, 14:20:59 INFO - 'name': 'check_screen_resolution'},), 14:20:59 INFO - 'run_cmd_checks_enabled': True, 14:20:59 INFO - 'sps_profile': False, 14:20:59 INFO - 'sps_profile_interval': 0, 14:20:59 INFO - 'suite': 'dromaeojs', 14:20:59 INFO - 'system_bits': '32', 14:20:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:20:59 INFO - 'title': 't-yosemite-r7-0088', 14:20:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:20:59 INFO - 'use_talos_json': True, 14:20:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:20:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:20:59 INFO - 'work_dir': 'build'} 14:20:59 INFO - ##### 14:20:59 INFO - ##### Running clobber step. 14:20:59 INFO - ##### 14:20:59 INFO - Running pre-action listener: _resource_record_pre_action 14:20:59 INFO - Running main action method: clobber 14:20:59 INFO - rmtree: /builds/slave/test/build 14:20:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - ##### 14:21:01 INFO - ##### Running read-buildbot-config step. 14:21:01 INFO - ##### 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: read_buildbot_config 14:21:01 INFO - Using buildbot properties: 14:21:01 INFO - { 14:21:01 INFO - "project": "", 14:21:01 INFO - "product": "firefox", 14:21:01 INFO - "script_repo_revision": "production", 14:21:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:21:01 INFO - "repository": "", 14:21:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:21:01 INFO - "buildid": "20160325131743", 14:21:01 INFO - "pgo_build": "False", 14:21:01 INFO - "basedir": "/builds/slave/test", 14:21:01 INFO - "buildnumber": 627, 14:21:01 INFO - "slavename": "t-yosemite-r7-0088", 14:21:01 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:21:01 INFO - "platform": "yosemite_r7", 14:21:01 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:21:01 INFO - "branch": "fx-team", 14:21:01 INFO - "repo_path": "integration/fx-team", 14:21:01 INFO - "revision": "2bac6e929e8f4edcef0a17cbe8c38d29381e0207", 14:21:01 INFO - "stage_platform": "macosx64", 14:21:01 INFO - "builduid": "2b08a6e5539b464eb85b2e8cf0eab456", 14:21:01 INFO - "slavebuilddir": "test" 14:21:01 INFO - } 14:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 14:21:01 INFO - Running post-action listener: _resource_record_post_action 14:21:01 INFO - ##### 14:21:01 INFO - ##### Running download-and-extract step. 14:21:01 INFO - ##### 14:21:01 INFO - Running pre-action listener: _resource_record_pre_action 14:21:01 INFO - Running main action method: download_and_extract 14:21:01 INFO - mkdir: /builds/slave/test/build/tests 14:21: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')]} 14:21:01 INFO - https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:21:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 14:21:02 INFO - Downloaded 1199 bytes. 14:21:02 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 14:21:02 INFO - Using the following test package requirements: 14:21:02 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:21:02 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 14:21:02 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 14:21:02 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'jsshell-mac.zip'], 14:21:02 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 14:21:02 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 14:21:02 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 14:21:02 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 14:21:02 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 14:21:02 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 14:21:02 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 14:21:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:21:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:02 INFO - https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:21:04 INFO - Downloaded 17943742 bytes. 14:21:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:21:07 INFO - Return code: 0 14:21:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:07 INFO - https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:21:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 14:21:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:21:09 INFO - Downloaded 17943742 bytes. 14:21:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:21:12 INFO - Return code: 0 14:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:12 INFO - https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:21:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:21:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:21:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 14:21:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:21:13 INFO - Downloaded 10847531 bytes. 14:21:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:21:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:21:14 INFO - Return code: 0 14:21: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')]} 14:21:14 INFO - https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 14:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 14:21:17 INFO - Downloaded 111383591 bytes. 14:21:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:17 INFO - mkdir: /builds/slave/test/properties 14:21:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:17 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:17 INFO - Contents: 14:21:17 INFO - build_url:https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 14:21:18 INFO - Running post-action listener: _resource_record_post_action 14:21:18 INFO - Running post-action listener: set_extra_try_arguments 14:21:18 INFO - ##### 14:21:18 INFO - ##### Running populate-webroot step. 14:21:18 INFO - ##### 14:21:18 INFO - Running pre-action listener: _resource_record_pre_action 14:21:18 INFO - Running main action method: populate_webroot 14:21:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:18 INFO - '--tppagecycles', 14:21:18 INFO - '7'], 14:21:18 INFO - 'tests': ['tsvgm']}}, 14:21:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:21:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:21:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'tests': ['damp', 'tps']}, 14:21:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['damp', 'tps']}, 14:21:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:21:18 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['dromaeo_dom']}, 14:21:18 INFO - 'other': {'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'other_l64': {'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'other_nol64': {'tests': ['a11yr', 14:21:18 INFO - 'ts_paint', 14:21:18 INFO - 'tpaint', 14:21:18 INFO - 'sessionrestore', 14:21:18 INFO - 'sessionrestore_no_auto_restore', 14:21:18 INFO - 'tabpaint']}, 14:21:18 INFO - 'svgr': {'tests': ['tsvgx', 14:21:18 INFO - 'tsvgr_opacity', 14:21:18 INFO - 'tart', 14:21:18 INFO - 'tscrollx', 14:21:18 INFO - 'cart']}, 14:21:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['tsvgx', 14:21:18 INFO - 'tsvgr_opacity', 14:21:18 INFO - 'tart', 14:21:18 INFO - 'tscrollx', 14:21:18 INFO - 'cart']}, 14:21:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'tests': ['tp5o']}, 14:21:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'talos_options': ['--e10s'], 14:21:18 INFO - 'tests': ['tp5o']}, 14:21:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'talos_options': ['--xperf_path', 14:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:18 INFO - 'tests': ['tp5n']}, 14:21:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:18 INFO - 'talos_options': ['--e10s', 14:21:18 INFO - '--xperf_path', 14:21:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:18 INFO - 'tests': ['tp5n']}}, 14:21:18 INFO - 'talos.zip': {'path': '', 14:21:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:18 INFO - Running post-action listener: _resource_record_post_action 14:21:18 INFO - ##### 14:21:18 INFO - ##### Running create-virtualenv step. 14:21:18 INFO - ##### 14:21:18 INFO - Running pre-action listener: _resource_record_pre_action 14:21:18 INFO - Running main action method: create_virtualenv 14:21:18 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:21:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:18 INFO - Using real prefix '/tools/python27' 14:21:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:18 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:21 INFO - Installing pip.................done. 14:21:21 INFO - Return code: 0 14:21:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:21 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:21:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:21:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:21 INFO - 'HOME': '/Users/cltbld', 14:21:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:21 INFO - 'LOGNAME': 'cltbld', 14:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:21 INFO - 'MOZ_NO_REMOTE': '1', 14:21:21 INFO - 'NO_EM_RESTART': '1', 14:21:21 INFO - 'PAGER': '/bin/cat', 14:21:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:21 INFO - 'PWD': '/builds/slave/test', 14:21:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:21 INFO - 'SHELL': '/bin/bash', 14:21:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:21 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:21 INFO - 'USER': 'cltbld', 14:21:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:21 INFO - 'XPC_FLAGS': '0x0', 14:21:21 INFO - 'XPC_SERVICE_NAME': '0', 14:21:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:21:22 INFO - Cleaning up... 14:21:22 INFO - Return code: 0 14:21:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:22 INFO - 'HOME': '/Users/cltbld', 14:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:22 INFO - 'LOGNAME': 'cltbld', 14:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:22 INFO - 'MOZ_NO_REMOTE': '1', 14:21:22 INFO - 'NO_EM_RESTART': '1', 14:21:22 INFO - 'PAGER': '/bin/cat', 14:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:22 INFO - 'PWD': '/builds/slave/test', 14:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:22 INFO - 'SHELL': '/bin/bash', 14:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:22 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:22 INFO - 'USER': 'cltbld', 14:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:22 INFO - 'XPC_FLAGS': '0x0', 14:21:22 INFO - 'XPC_SERVICE_NAME': '0', 14:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:22 INFO - Downloading/unpacking psutil>=0.7.1 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:24 INFO - Installing collected packages: psutil 14:21:24 INFO - Running setup.py install for psutil 14:21:24 INFO - building 'psutil._psutil_osx' extension 14:21:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:21:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:21:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:21:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:21:25 INFO - building 'psutil._psutil_posix' extension 14:21:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:21:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:21:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:21:25 INFO - ^ 14:21:25 INFO - 1 warning generated. 14:21:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:21:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:26 INFO - Successfully installed psutil 14:21:26 INFO - Cleaning up... 14:21:26 INFO - Return code: 0 14:21:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:26 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:26 INFO - 'HOME': '/Users/cltbld', 14:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:26 INFO - 'LOGNAME': 'cltbld', 14:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:26 INFO - 'MOZ_NO_REMOTE': '1', 14:21:26 INFO - 'NO_EM_RESTART': '1', 14:21:26 INFO - 'PAGER': '/bin/cat', 14:21:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:26 INFO - 'PWD': '/builds/slave/test', 14:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:26 INFO - 'SHELL': '/bin/bash', 14:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:26 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:26 INFO - 'USER': 'cltbld', 14:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:26 INFO - 'XPC_FLAGS': '0x0', 14:21:26 INFO - 'XPC_SERVICE_NAME': '0', 14:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:21:28 INFO - Installing collected packages: mozsystemmonitor 14:21:28 INFO - Running setup.py install for mozsystemmonitor 14:21:29 INFO - Successfully installed mozsystemmonitor 14:21:29 INFO - Cleaning up... 14:21:29 INFO - Return code: 0 14:21:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:29 INFO - 'HOME': '/Users/cltbld', 14:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:29 INFO - 'LOGNAME': 'cltbld', 14:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:29 INFO - 'MOZ_NO_REMOTE': '1', 14:21:29 INFO - 'NO_EM_RESTART': '1', 14:21:29 INFO - 'PAGER': '/bin/cat', 14:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:29 INFO - 'PWD': '/builds/slave/test', 14:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:29 INFO - 'SHELL': '/bin/bash', 14:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:29 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:29 INFO - 'USER': 'cltbld', 14:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:29 INFO - 'XPC_FLAGS': '0x0', 14:21:29 INFO - 'XPC_SERVICE_NAME': '0', 14:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:32 INFO - Downloading docopt-0.6.1.tar.gz 14:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:33 INFO - Running setup.py install for blobuploader 14:21:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:33 INFO - Running setup.py install for requests 14:21:33 INFO - Running setup.py install for docopt 14:21:33 INFO - Successfully installed blobuploader requests docopt 14:21:33 INFO - Cleaning up... 14:21:33 INFO - Return code: 0 14:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:33 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:21:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:33 INFO - 'HOME': '/Users/cltbld', 14:21:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:33 INFO - 'LOGNAME': 'cltbld', 14:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:33 INFO - 'MOZ_NO_REMOTE': '1', 14:21:33 INFO - 'NO_EM_RESTART': '1', 14:21:33 INFO - 'PAGER': '/bin/cat', 14:21:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:33 INFO - 'PWD': '/builds/slave/test', 14:21:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:33 INFO - 'SHELL': '/bin/bash', 14:21:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:33 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:33 INFO - 'USER': 'cltbld', 14:21:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:33 INFO - 'XPC_FLAGS': '0x0', 14:21:33 INFO - 'XPC_SERVICE_NAME': '0', 14:21:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JA_ZDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-iSOU54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-4ApunT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-UqMQWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-BIsf59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-GMKW1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-bS4KkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:34 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XJ4Bnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-O892LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-frlCAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-lVoJ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-sHwzVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-NwsIS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Rh_D00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-PgCT1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Pmh0KH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:35 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-z1cb2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:35 INFO - Running setup.py install for manifestparser 14:21:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozcrash 14:21:36 INFO - Running setup.py install for mozdebug 14:21:36 INFO - Running setup.py install for mozdevice 14:21:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozfile 14:21:36 INFO - Running setup.py install for mozhttpd 14:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozinfo 14:21:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozInstall 14:21:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozleak 14:21:37 INFO - Running setup.py install for mozlog 14:21:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for moznetwork 14:21:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozprocess 14:21:37 INFO - Running setup.py install for mozprofile 14:21:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozrunner 14:21:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:38 INFO - Running setup.py install for mozscreenshot 14:21:38 INFO - Running setup.py install for moztest 14:21:38 INFO - Running setup.py install for mozversion 14:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:38 INFO - Cleaning up... 14:21:38 INFO - Return code: 0 14:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:38 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:21:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:38 INFO - 'HOME': '/Users/cltbld', 14:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:38 INFO - 'LOGNAME': 'cltbld', 14:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:38 INFO - 'MOZ_NO_REMOTE': '1', 14:21:38 INFO - 'NO_EM_RESTART': '1', 14:21:38 INFO - 'PAGER': '/bin/cat', 14:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:38 INFO - 'PWD': '/builds/slave/test', 14:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:38 INFO - 'SHELL': '/bin/bash', 14:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:38 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:38 INFO - 'USER': 'cltbld', 14:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:38 INFO - 'XPC_FLAGS': '0x0', 14:21:38 INFO - 'XPC_SERVICE_NAME': '0', 14:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-QMncS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:38 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cU7F6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WP4s4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-UJh1WL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-b2UnKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zpQ9jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hdSmJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-CmJzi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pC7twZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-YBhNRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-os7jrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:39 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-q_1DaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-oWc5Py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-g0ePe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-KWsgNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-BfsvwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:40 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-5QZxjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:43 INFO - Downloading blessings-1.6.tar.gz 14:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:21:43 INFO - Installing collected packages: blessings 14:21:43 INFO - Running setup.py install for blessings 14:21:43 INFO - Successfully installed blessings 14:21:43 INFO - Cleaning up... 14:21:43 INFO - Return code: 0 14:21:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:43 INFO - Reading from file tmpfile_stdout 14:21:43 INFO - Current package versions: 14:21:43 INFO - blessings == 1.6 14:21:43 INFO - blobuploader == 1.2.4 14:21:43 INFO - docopt == 0.6.1 14:21:43 INFO - manifestparser == 1.1 14:21:43 INFO - mozInstall == 1.12 14:21:43 INFO - mozcrash == 0.17 14:21:43 INFO - mozdebug == 0.1 14:21:43 INFO - mozdevice == 0.48 14:21:43 INFO - mozfile == 1.2 14:21:43 INFO - mozhttpd == 0.7 14:21:43 INFO - mozinfo == 0.9 14:21:43 INFO - mozleak == 0.1 14:21:43 INFO - mozlog == 3.1 14:21:43 INFO - moznetwork == 0.27 14:21:43 INFO - mozprocess == 0.22 14:21:43 INFO - mozprofile == 0.28 14:21:43 INFO - mozrunner == 6.11 14:21:43 INFO - mozscreenshot == 0.1 14:21:43 INFO - mozsystemmonitor == 0.0 14:21:43 INFO - moztest == 0.7 14:21:43 INFO - mozversion == 1.4 14:21:43 INFO - psutil == 3.1.1 14:21:43 INFO - requests == 1.2.3 14:21:43 INFO - wsgiref == 0.1.2 14:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:43 INFO - 'HOME': '/Users/cltbld', 14:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:43 INFO - 'LOGNAME': 'cltbld', 14:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:43 INFO - 'MOZ_NO_REMOTE': '1', 14:21:43 INFO - 'NO_EM_RESTART': '1', 14:21:43 INFO - 'PAGER': '/bin/cat', 14:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:43 INFO - 'PWD': '/builds/slave/test', 14:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:43 INFO - 'SHELL': '/bin/bash', 14:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:43 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:43 INFO - 'USER': 'cltbld', 14:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:43 INFO - 'XPC_FLAGS': '0x0', 14:21:43 INFO - 'XPC_SERVICE_NAME': '0', 14:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:21:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:21:43 INFO - Cleaning up... 14:21:43 INFO - Return code: 0 14:21:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:44 INFO - 'HOME': '/Users/cltbld', 14:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:44 INFO - 'LOGNAME': 'cltbld', 14:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:44 INFO - 'MOZ_NO_REMOTE': '1', 14:21:44 INFO - 'NO_EM_RESTART': '1', 14:21:44 INFO - 'PAGER': '/bin/cat', 14:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:44 INFO - 'PWD': '/builds/slave/test', 14:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:44 INFO - 'SHELL': '/bin/bash', 14:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:44 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:44 INFO - 'USER': 'cltbld', 14:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:44 INFO - 'XPC_FLAGS': '0x0', 14:21:44 INFO - 'XPC_SERVICE_NAME': '0', 14:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:44 INFO - Downloading/unpacking jsonschema 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:46 INFO - Downloading/unpacking functools32 (from jsonschema) 14:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:47 INFO - warning: no files found matching '*.txt' 14:21:47 INFO - no previously-included directories found matching 'build' 14:21:47 INFO - no previously-included directories found matching 'dist' 14:21:47 INFO - no previously-included directories found matching '.git*' 14:21:47 INFO - Installing collected packages: jsonschema, functools32 14:21:47 INFO - Running setup.py install for functools32 14:21:47 INFO - warning: no files found matching '*.txt' 14:21:47 INFO - no previously-included directories found matching 'build' 14:21:47 INFO - no previously-included directories found matching 'dist' 14:21:47 INFO - no previously-included directories found matching '.git*' 14:21:47 INFO - Successfully installed jsonschema functools32 14:21:47 INFO - Cleaning up... 14:21:47 INFO - Return code: 0 14:21:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:47 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 0x1029bea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029ce420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9403562920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, '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.IgP2QxRKEw/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.modjbbIFES/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:21:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:21:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:47 INFO - 'HOME': '/Users/cltbld', 14:21:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:47 INFO - 'LOGNAME': 'cltbld', 14:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:47 INFO - 'MOZ_NO_REMOTE': '1', 14:21:47 INFO - 'NO_EM_RESTART': '1', 14:21:47 INFO - 'PAGER': '/bin/cat', 14:21:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:47 INFO - 'PWD': '/builds/slave/test', 14:21:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:47 INFO - 'SHELL': '/bin/bash', 14:21:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:21:47 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:21:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:47 INFO - 'USER': 'cltbld', 14:21:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:47 INFO - 'XPC_FLAGS': '0x0', 14:21:47 INFO - 'XPC_SERVICE_NAME': '0', 14:21:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:47 INFO - Downloading/unpacking flake8 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:21:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:21:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:51 INFO - no previously-included directories found matching 'docs/_build' 14:21:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:21:51 INFO - Running setup.py install for pep8 14:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:21:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:21:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:21:51 INFO - no previously-included directories found matching 'docs/_build' 14:21:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:21:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:21:51 INFO - Cleaning up... 14:21:51 INFO - Return code: 0 14:21:51 INFO - Running post-action listener: _resource_record_post_action 14:21:51 INFO - Running post-action listener: _start_resource_monitoring 14:21:51 INFO - Starting resource monitoring. 14:21:51 INFO - ##### 14:21:51 INFO - ##### Running install step. 14:21:51 INFO - ##### 14:21:51 INFO - Running pre-action listener: _resource_record_pre_action 14:21:51 INFO - Running main action method: install 14:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:51 INFO - Reading from file tmpfile_stdout 14:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:52 INFO - Reading from file tmpfile_stdout 14:21:52 INFO - Output received: 14:21:52 INFO - Usage: mozinstall [options] installer 14:21:52 INFO - Options: 14:21:52 INFO - -h, --help show this help message and exit 14:21:52 INFO - -d DEST, --destination=DEST 14:21:52 INFO - Directory to install application into. [default: 14:21:52 INFO - "/builds/slave/test"] 14:21:52 INFO - --app=APP Application being installed. [default: firefox] 14:21:52 INFO - mkdir: /builds/slave/test/build/application 14:21:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:21:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:26 INFO - Reading from file tmpfile_stdout 14:22:26 INFO - Output received: 14:22:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:22:26 INFO - Running post-action listener: _resource_record_post_action 14:22:26 INFO - ##### 14:22:26 INFO - ##### Running run-tests step. 14:22:26 INFO - ##### 14:22:26 INFO - Running pre-action listener: _resource_record_pre_action 14:22:26 INFO - Running main action method: run_tests 14:22:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:26 INFO - 2016-03-25 14:22:26.385 screenresolution[1644:7773] starting screenresolution argv=screenresolution get 14:22:26 INFO - 2016-03-25 14:22:26.387 screenresolution[1644:7773] Display 0: 1600x1200x32@60 14:22:26 INFO - 2016-03-25 14:22:26.393 screenresolution[1645:7776] starting screenresolution argv=screenresolution list 14:22:26 INFO - Available Modes on Display 0 14:22:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:26 INFO - Intel Iris: 14:22:26 INFO - Chipset Model: Intel Iris 14:22:26 INFO - Type: GPU 14:22:26 INFO - Bus: Built-In 14:22:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:26 INFO - Vendor: Intel (0x8086) 14:22:26 INFO - Device ID: 0x0a2e 14:22:26 INFO - Revision ID: 0x0009 14:22:26 INFO - Displays: 14:22:26 INFO - Display: 14:22:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:26 INFO - Display Serial Number: 1600x1200 60 14:22:26 INFO - Main Display: Yes 14:22:26 INFO - Mirror: Off 14:22:26 INFO - Online: Yes 14:22:26 INFO - Rotation: Supported 14:22:26 INFO - Return code: 0 14:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:26 INFO - Python 2.7.3 14:22:26 INFO - Return code: 0 14:22:26 INFO - grabbing minidump binary from tooltool 14:22:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:26 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 0x10285de00>, '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 0x102686db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102858b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:22:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:22:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:26 INFO - Return code: 0 14:22:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:22:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:22:27 INFO - Return code: 0 14:22:27 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/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:22:27 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/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IgP2QxRKEw/Render', 14:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:27 INFO - 'HOME': '/Users/cltbld', 14:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:27 INFO - 'LOGNAME': 'cltbld', 14:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:27 INFO - 'MOZ_NO_REMOTE': '1', 14:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:27 INFO - 'NO_EM_RESTART': '1', 14:22:27 INFO - 'PAGER': '/bin/cat', 14:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:27 INFO - 'PWD': '/builds/slave/test', 14:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:27 INFO - 'SHELL': '/bin/bash', 14:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.modjbbIFES/Listeners', 14:22:27 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 14:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:27 INFO - 'USER': 'cltbld', 14:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:27 INFO - 'XPC_FLAGS': '0x0', 14:22:27 INFO - 'XPC_SERVICE_NAME': '0', 14:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:27 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/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:22:28 INFO - mozversion application_buildid: 20160325131743 14:22:28 INFO - mozversion application_changeset: 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 14:22:28 INFO - mozversion application_display_name: Nightly 14:22:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:28 INFO - mozversion application_name: Firefox 14:22:28 INFO - mozversion application_remotingname: firefox 14:22:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:22:28 INFO - mozversion application_vendor: Mozilla 14:22:28 INFO - mozversion application_version: 48.0a1 14:22:28 INFO - mozversion platform_buildid: 20160325131743 14:22:28 INFO - mozversion platform_changeset: 2bac6e929e8f4edcef0a17cbe8c38d29381e0207 14:22:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:22:28 INFO - mozversion platform_version: 48.0a1 14:22:28 INFO - using testdate: 1458940948 14:22:28 INFO - actual date: 1458940948 14:22:28 INFO - starting webserver on 'localhost:49270' 14:22:28 INFO - SUITE-START | Running 2 tests 14:22:28 INFO - TEST-START | dromaeo_css 14:22:28 INFO - operating with platform_type : mac_ 14:22:28 INFO - Initialising browser for dromaeo_css test... 14:22:28 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmp7oSwBl/profile http://localhost:49270/getInfo.html) 14:22:30 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 14:22:30 INFO - PROCESS | 1663 | colorDepth:24 14:22:30 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 14:22:30 INFO - PROCESS | 1663 | __metrics 14:22:30 INFO - PROCESS | 1663 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:22:30 ERROR - PROCESS | 1663 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:22:31 INFO - TEST-INFO | 1663: exit 0 14:22:31 INFO - Browser initialized. 14:22:31 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:31 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmp7oSwBl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:43 INFO - PROCESS | 1666 | RSS: Main: 243994624 14:22:43 INFO - PROCESS | 1666 | 14:23:34 INFO - PROCESS | 1666 | 1458941014296 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:25:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 14:25:45 INFO - PROCESS | 1666 | RSS: Main: 377761792 14:25:45 INFO - PROCESS | 1666 | 14:28:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 14:28:48 INFO - PROCESS | 1666 | RSS: Main: 370647040 14:28:48 INFO - PROCESS | 1666 | 14:31:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 14:31:51 INFO - PROCESS | 1666 | RSS: Main: 374931456 14:31:51 INFO - PROCESS | 1666 | 14:34:53 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 14:34:54 INFO - PROCESS | 1666 | RSS: Main: 334372864 14:34:54 INFO - PROCESS | 1666 | 14:37:57 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 14:37:57 INFO - PROCESS | 1666 | RSS: Main: 334082048 14:37:57 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 14:41:00 INFO - PROCESS | 1666 | RSS: Main: 442830848 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | __start_tp_report 14:41:00 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 14:41:00 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 14:41:00 INFO - PROCESS | 1666 | |i|pagename|runs| 14:41:00 INFO - PROCESS | 1666 | |0;dojo.html;2635.9868200659;3450.603180634226;3471;3496.807675577843;3532.2582257725876;5487.5609951203905;5600.299962504687;5608.2428872102255;5632.943670563293;5644.125160600109;5569.053260945639;5709.628874123179;5714.542836573075;5725.169850371693;5763.855903602402;5073.391193056838;5122.795088196468;5172.27588137661;5176.301199338088;5187.896242075156;5076.086304465213;5171.09505836479;5279.128943724281;5286.04851126797;5291.735413229342;5162.096633089194;5184.585233181337;5234.58123350133;5246.422893481714;5249.291345668343;4277.2087163874785;5046.621503387224;5070.594352451795;5173.637845350827;5200.609954253446;5033.299116817152;5081.644284900059;5087.542121209072;5100.69395836251;5106.795728170869;5547.3343198816;5556.611037227396;5566.721663916828;5601.215829783833;5613.578981576357;6002.759889604411;6046.469991446036;6057.011860859147;6064.773978780771;6072.886587673032;6072.635641861502;6106.946476819281;6118.082287656843;6151.077338399231;6235.469985051276;5745.425457454263;5745.511631511285;5755.395683453261;5765.077587586008;5798.507126894219;6164.660943648053;6188.319284878659;6218.626882387071;6218.81343559694;6272;5969.940300597025;6048.818535443944;6068.120122582201;6108.17539632144;6116.571839971249;6102.267727872683;6102.847428814315;6136.110264011693;6192.659403732748;6209.130721698965;6107.480864126599;6114.510272098639;6136.693165341715;6145.877082458326;6147.047207682816;6136.858522390323;6162.661053642003;6163.84590385244;6164.4760195383;6164.7842325518395;4766.976165119152;4829.154897892855;4843.830465933675;4868.683535570177;4901.166801643729;4320.567943205654;4330.155619654201;4353.695241333076;4371.628411584988;4379.014721687595;5614.438556144353;5617.101263797773;5622.184783206412;5630.5495560355075;5665.405132461115;6073.665948372882;6122.977604208209;6160.907586386208;6192.783252586138;6201.658908759971;5606.831795046155;5609.859753506195;5620.831375058755;5657;5672.007398705293;5302.761375738101;5305.257263983045;5316.0696878046965;5341.385740639798;5384.9730751346;6132.783850801441;6211.409916057877;6260.029695397221;6265.8746825063245;6301.0863424804065;6168.444839964424;6176.969115154396;6180.721867515883;6194.5973511721595;6226.875462490815;6235.033569796688;6237.937620623918;6241.78153764616;6257.8122656318565;6265.498760099273;5953.10703394477;6060.454559089703;6129.756146212572;6142.877142457215;6143.419763699168;5982.551308651781;6138.572327483795;6169.907451388143;6191;6213.2233470816145;5875.618084824473;6054.122152287981;6067.878642427215;6073.0283154695035;6093.390660933871;5994.820155395345;6025.548083893813;6062.242219722535;6088.6042407243385;6138.109974053648;5886.558508111823;5898.64608123514;5906.173135761082;5928.614640048383;5942.019566771434;5776.971115144565;5936.079907614327;5953.7023148843255;5964.522838173022;5973.850653733692;5619.185218143428;5727.713614319351;5746.741396637078;5836.591438599427;5910.556708246812 14:41:00 INFO - PROCESS | 1666 | |1;ext.html;491.0620714435429;577.9162021506882;578.7800635758412;585.9346812717379;637.7544645311557;24588;30870.919517816827;30874.382512349766;30907;38114;31877.36245275093;43266.70199894001;43420;43618;43753.56246437535;9244.260459163268;9481.146696797286;9500.28747843911;9503.762405939873;9523.857142142873;9273.489958052338;9421.858672119924;9430.528473576329;9431.151196392324;9442.386244894094;7512.549247045167;9372.67195648149;9549.61801527938;9555.522223888813;9585.472798996052;9448.149666530011;9548.18840398567;9556.187724043464;9559.665411710557;9566.37818541796;9485.288603354707;9616.23070154386;9616.855747163798;9627.903720962771;9634;41539.7923010386;41572.79213603943;42015.57984420147;42077.57922420767;42166.367504487454;3236.4983427568764;3240.4329242382723;3394.372041172366;3466.480027995796;3467.8959631211105;28139.155825325273;28309.409492410756;28593.857030714713;28633;29036;2748.0656576763795;2780.06867699321;2787;2815.3665425279355;2927.3044446322033;497261;497876.0212397866;498970.9999999964;499889;500442;66657.6667116671;67042.66478667576;67319.99020014703;67432;67436.66281668658;72001.63999180075;75357;76453.61773191098;76544.23455765483;76587;16909.7463538047;17092.91453542749;17144.657106857794;17154.742678859828;17207.225674844663;11447.885521144683;12652.240865548096;13012.804807927889;13056.106864504594;13065.477380904656;21464.57070858574;21765.564688706454;21906;22298.44253893633;22378.664320035212;8597.52713600758;8755.518446485505;8809.414305424956;8818.33862460318;8891.866622000674;874.9212570868652;888.3071204460531;982.5824024789435;1109.839073334362;1152.913531485142;24398.390040249134;28705.856470717932;29437.852810736236;29781.851090744407;29947.850260748557;1064.3932958213898;1159.8260260960924;1163.959261425863;1172.1677608897778;1178.3106882473849;12098.274103553815;14962.476313328982;15046.097234165765;15375.461858834888;15656.217189140498;539757;540946;543138;547160;547657;50380;60072.798544028876;60631;60673.39326606766;60759.6962015196;1269.5873841001712;1355.2817006986313;1426.1371870018697;1447.4210315873524;1491.4854375240525;28524;28743.712562874105;28777.992770252942;28961.275968100967;29146.417071658023;46241;46771.29843052289;47133.76433117812;47172.82067948329;47214.76392618015;315523;317108.31566737074;317745;317780;319148;29319.41361172722;32834.67165328316;33585.664143358255;33792.662073379935;34142.658573413944;42000.949976250835;42634.36048459337;42709.78645106754;42840.57159428366;43502.56497434985;34668.82665586656;34971.825140874134;35530.822345888104;35711.10722231965;35788.28423431465;32464.675353246166;34321.82839085789;35574.28851423009;35804.4629330555;36794.448083279305;35693.64306357007;35717.82141089278;35904;36029.166230568844;36579.817100914326;30889.536656949713;31699.52450713195;31839.522407163447;31882.68117318797;31958.840205799752;19833.900830495757;23612;23709.644355334338;23841.165559205343;24040.75959240385 14:41:00 INFO - PROCESS | 1666 | |2;jquery.html;303.3220751620129;308.56338281331915;360.41972424396715;369.5067085440936;369.5417682074229;19246;19698.507537311576;19736.474346176878;21122.15511379543;21144.8942755286;19165;19609.11758970846;20396.490087747814;20459.590808183828;20502.487437814063;5586.10622300432;5739.253896993385;5790.652560846363;5792.536597072245;5796.362400135981;4158.563350848162;4281.892952676192;4365.454318210223;4368.453943257093;5851.970740146293;6047.274327080757;6356.84107897304;6361.077643741654;6366.618002919817;6373.203349581302;6156.415140561662;6337.429631333179;6429.678516074225;6442.098106265126;6453.645049522274;3740.1023754299044;5242.135047717122;5501.642393244426;5526.392096869341;5540.50135487804;23359.532809343717;23926.401839953967;24117.87941060301;24227.87886060576;24260.878695606585;2044.4071219346372;2121.2999710095633;2196.2203417786777;2379.4170428245193;2416.2751174647537;13902.652433689138;14114.717705645933;14204.786928196085;14272.571822845228;14649.414023439049;1652.6859896619603;1757.736339549078;1772.7163653815458;1791.7133258678548;1864.962700745991;86035.27929441439;89649;91688.44015247276;93033;94488.99999999932;9903.207743380512;10034.147097496794;10266.538005789758;10389.896101039045;10534.36793792375;12553.623391298275;12599.559015434415;12610.369481525888;12627.242365458102;12634.81047784284;6858.759943401957;8220.260176584135;8412.579371031425;8512.74461766148;8521.957390213132;8705.260052895448;8719.564021798884;8730.563471826383;8845.646174152962;8848.46909185451;4923.532264434873;6002.369751176151;6009.308929473079;6016.217891674054;6040.546958978006;1505.0518173550593;1521.2849960518538;1692.4668729350215;1762.7091529897423;1796.1378538301688;937.3625934364561;972.5672075926145;1044.2951008069522;1069.5828626835541;1078.9892101078888;19642.803571964098;20348.49128771763;20614.278500252418;20834.58330833375;20960.266390676254;957.9233661307079;972.1202311907734;990.8612794208816;995.3629677006577;1082.9620963266248;10907.509162087725;11201.887981120248;11227.831582526269;11232.382218978035;11233.933675814968;599360.0031999812;600233;605570;618502;628253;98060.50969745105;98422.99999999857;100328;101936;102248.48875755722;953.7186529973675;993.8608594796734;997.9650712225183;1002.884668263159;1006.7986402719486;15550.300236489158;15778.211089445711;18248.17883195286;18249.792854219435;18379.897206167672;43018;43506.129877402906;43562.564374355854;43732.56267437285;44824.77587612041;63010;63203;63757.04364434444;63872.36127638664;64281;7606.429517786078;7622.047244094489;7670;7751.728689495841;7945.523268603903;12372.07209459312;12699.492020319083;12914;13032.41354139085;13062.673433163867;10984.06635435965;11303.92612701792;11360.431978401211;11450.427478625868;11458.541658333574;10706.839397408889;10745.409002504937;10818.404987725751;10890.346579205274;11166.776664466828;11064.778704426028;11279.943600281946;11286.322820630789;11554.537818487503;11736.354500502213;7539.283768042027;7761.107472640719;7791.727289544839;7803.375729941477;8007.91992080095;9433.151016408281;10889;11205.60780372683;11442.771144576895;11450.255733377304 14:41:00 INFO - PROCESS | 1666 | |3;mootools.html;1453.6729235921925;1593.7450007998718;1634.4851371817872;1896.819802118799;2006.5084054406673;7970.202979702027;8646.221840034395;8797.252233560155;8809.427387219843;8841.248493878013;8524.957375213131;8791.384603077771;8799;8825.823483530325;8828.426152300097;2466.976204874975;2469.148143890364;2469.6912885889265;2499.550080985422;2499.5875680512695;2427.9514409711796;2517.5216708825265;2517.924462266135;2527.545041892459;2532.227670560478;2388.379021454417;2400.219928523228;2432.3675844280438;2435.257246539805;2436.2691192642224;2476.3437689012335;2491.9377015574573;2504.9479218727997;2506.5112303100905;2512.623106534016;2115.883626400547;2443.3525115844313;2482.2801387597574;2483.900643974257;2528.469021505486;8679.826403471896;8724;8736.475811451333;8744.825103497895;8755.956220218923;5380.058489764315;5542.584306177053;5551.306086739158;5571.275734154575;5590.5527557795685;3467.8959631211105;3540.5751309842985;3610.3824727072924;3615.9819200903826;3620.0406892173596;1051.5636011055403;1055.5039131608132;1061.376094575301;1065.387402243713;1072.8980746829038;11944.984676302525;11958.999999999913;11976.820347694791;11977.94011029948;12012.819807702805;4846.7818948147415;4856.344393506902;4879.804807807648;4975.0796102721115;4984.526469985346;10149.289549731595;10159.542820573091;10160.288779785344;10163.18694504438;10180.389176649276;5513.283273174462;5543.944560554342;5552.7778888843995;5568.554515638739;5578.023845826964;4446.799894004777;4610.354550362952;4855.344528488679;5001.124803159432;5017.4731653175895;2798.0766347105405;3792.791396473165;3850.6330252760426;3893.299206142865;3899.991504375249;1171.4142928535732;1327.9535216267384;1336.87968082873;1348.083303353729;1354.4852955876704;1027.0448482910815;1040.953157107932;1172.1443346357207;1262.6085913366885;1405.9859401406059;7933.722319718782;7976.680932762741;8046.678132874737;8047.557384343917;8065.193480652005;1190.9166358354832;1201.4173126033866;1215.440897187286;1230.39095647655;1235.5490246060303;6143.140856217124;6164.7842325518395;6212.751489940442;6239.688015599202;6258.155149054819;10362.481875906175;10902.890971090346;10938.398388088732;10945.671629851116;10949.343039417661;10069.093781559548;10663.253572250023;10671.46642667879;10719;10797;7388;7819.944307518526;8174.754757357289;8279.254867061993;8308.83382332362;7963.681452742057;8002;8029.4379393441895;8091.878621820795;8127.593620319079;9224.308176886627;9446;9478.099580539838;9485.478298693362;9583.945765965598;9685.564149613425;9700.5149742514;9733.367331123454;9987.60049598008;10172;7571.432142589438;7605.163432022584;7638.579878106758;7722.266384693445;7724.6137693114;8240.1347858474;8269.173082691683;8316.833663326579;8347.123552027193;8360.87458688108;6235.314115447388;7444.143923448656;7562.092548893947;7685.615719213905;7724.497907635986;7111.751088711871;7283.672234749555;7322.2677732228485;7332.926670733438;7334.816629584303;7703.614819259126;7742.729004484816;7750.806229844299;7766.378689704923;7776.533407995538;6911.101556797584;6917.100776898971;7025.6487175639995;7031.929680703128;7037.437005039687;7051.330123638246;7120.501564890408;7130.857382852418;7134.607596582237;7134.892976605459 14:41:00 INFO - PROCESS | 1666 | |4;prototype.html;270.56844333288404;333.10727250967415;334.46819556904524;339.66373290442453;341.4042495844751;6390.424861762441;6541.640209788466;6594.274629790719;6618.205815302158;6620.569662971903;6420.807375778722;6491.610503369801;6491.967540162304;6500.414962653372;6555;3727.664510194082;4058.127502586943;4777.474477807438;4901.558859702626;4927.778249978742;4625.884352891171;4878.438979517366;4885.853424397256;4886.877828054292;4891.14404979129;4794.472608013116;4817.686850354733;4823.951760482403;4827.203511420611;4830.468648448667;4572.039871626962;4662.254039353687;4815.3258543803895;4835.806567737286;4850.611951043908;4101.343784994417;4125.690573206992;4140.958590414088;4151.169766046803;4151.46031015966;5624.662520248758;5706.28671416073;6214.8135555933395;6217.595856269328;6227.844303892393;4528.9547104528865;4701.858944231679;5262.184361423985;5495.53287970519;5626.521745651625;6889.414399776025;6889.448844092461;6895.586264824076;6897.172339319314;6897.241303456616;3724.348239058181;4313.698041137121;4547.931781023287;4548.613367863735;4575.062112266977;6151.846203844851;7227.1327440707455;7236.769749142659;7276;7379.3727533159745;4574.588287054181;4585.495595484494;4595.747233902168;4597.931031034537;4606.8157273708675;4648.1865673507;4672.08894265615;4674.929876051794;4687.7656117194;4689;4714.292856071548;5461.344638643388;5515.283013208337;5520.641158324696;5543.6396634218645;6652.933470665328;6898.724051037902;6938.444924406035;6958.721651133898;6973.267806880306;1449.4492093004592;1490.2548725637182;1584.255399962016;1609.3321271672125;1620.6110533472117;968.0464742228899;1015.6140666546665;1022.8850552897378;1042.2547878267076;1043.7442826507402;5316.548093412026;6205.6586887721605;6320.873582528324;6412.775552855627;6512.869742605121;7262.636868156676;7267.164276108209;7270.272972702687;7270.9636451817405;7279.1265048194555;6487.772927947593;6492.35076492347;6500.252470965805;6518.608883466913;6533.216014078341;3791.279656865187;3827.4641550182996;3847.4228865670375;3852.5184351956004;3858.903527411781;7236.855262894713;7482.064741907262;7558.941748155263;7569.356604688553;7585.279398457138;7409.555426674417;7451.478396512301;7465.514741541782;7469.775906722807;7494.213107623621;6154.446099850946;6487.870242595027;7133.573285342848;7517.323440890346;7538.3592394645975;6029.944759666953;7027.508074434741;7207.387372073433;7211.963940180265;7222.422206223595;6770.390664839991;7119.1457025157315;7126.180489243803;7132;7138.286171383028;7533.54798712079;7533.886991695019;7553.7356192533;7563.773086807405;7566.205548417337;4266.488021437447;4599.93100103492;4601.700889442175;4604.792784324646;4625.098105869458;6850;7169.533980291264;7194.244604316471;7208.423326134001;7214.71141154348;5642.971785141048;6653.467722582279;6970.442364610718;6989.47578931572;7057;6787.966060169668;6973.686184121625;7022;7046.1192350956135;7049.08361912948;6857.314268573103;6870.519063665495;6873.862522749417;6876.106106206161;6902.275261097512;6097.74996125802;6664.833379165366;7017.5087743859485;7020.052292940388;7023.964880175567;6599.109120268894;6627.972664237051;6743.15710536183;6800.829979250559;6850.9314906850295 14:41:00 INFO - PROCESS | 1666 | |5;yui.html;624.6158612453341;688.707299397756;723.7105157936828;747.6373958630063;756.2513112019103;14647.780283295746;14817.333220005099;14832.406703731851;14835.92582037091;14853.851461485381;13606.659833504142;13678.589642310722;13679.24764137972;13688;13703.725925481509;735.3528894572769;893.120276527623;899.5232526760827;922.349743430883;927.3925578745899;901.8331608652387;909.3498148823589;911.858661907402;913.9900410046902;916.8212198621271;968.6173961285288;970.1268858027761;972.2027937091552;973.0318333258382;974.5273542331963;764.2739397572301;942.5993952570165;962.2879069488528;966.5312323523086;969.5346233807742;722.7759394587695;725.542907967982;727.6325455644866;727.6434547071949;728.279003786253;14120;14348.139111653334;14551.417943282257;14605.269736513239;14623.561293161221;12220.694482637917;12409.131360804748;12521.624351269476;12692.984561235078;12750.426230819636;9944.403335799876;10005.749856253578;10034.89965100347;10038.949805251;10379.273450858444;3466.5146879436898;3499.0727457223857;3539.7168226541817;3543.5216245807;3612.1330880588735;82958.58520707418;84189.57905210496;84526.16633671291;84651;84702;9264.027277135938;9447.433154010781;9521.809563808823;9531.428114313163;9744.31789774723;21571;21580.352589422342;21582.89208553947;21588.244411445838;21599.67600485994;6190.226221722285;7146.32109949554;7261.128664560287;7261.329894124381;7469.551826890404;3946.940795888064;3976.343903255988;4001.7999100045463;4008.2584721826556;4043.6765058795227;3548.8048157351595;3582.5521809773777;3582.946255806165;3590.7306951978185;3598.3702852000797;607.271274470637;610.4658423879106;624.475440629864;626.1077963901513;636.9712913644523;501.0830180769184;558.4164548047219;615.3753939751156;616.740968793108;617.1575799034375;8006.719764808204;8255.587220638945;8295.917040829514;8327.750167494985;8347.165283471604;582.5223316880117;583.5011065538988;590.4066413254651;604.1843511259764;616.2420223125581;3375.29118885032;3586.444101164324;3712.7029837612927;3751.512303400595;3915.9216815663526;74468.62765686137;87787;87919.56040219757;89011.55494222487;89646.55176724074;77316;77675.61162194266;80303;80760.19239807644;81004;70570.2942970574;71081.57836843234;72146.27853721396;72531.6373418119;73596;8567.700130495403;8569.785755356166;8618.65525379003;8760.824783504167;8849.867251991354;48768.02463950772;48983;49810.25284620661;51347.74326128345;51752.74123629358;69761.65119174372;70835.58328833498;70977.64511177411;71254;73103.63448182725;10795.6221532246;11134;11163.553457861919;11265;11417.885821141683;11890.583829565923;12043.458044387848;12292.569760058355;12317;12430.564930227398;11495.77008459843;11496;11626.895444932718;11861;12001.219920705125;10898.727531811768;11484.712882178012;11491.425428728697;11491.540338386705;11727.76544469123;10828.24202305831;11314.830277546009;11427.314361138026;11719.589814356797;12250.938745306217;9329.72010839676;9346.252299816135;9388.76528086776;9821.508924553887;10036.447995360326;7848.7645370638975;8562.785930351542;8979.371443998858;9112.815334006536;9153.908460915305 14:41:00 INFO - PROCESS | 1666 | __end_tp_report 14:41:00 INFO - PROCESS | 1666 | __start_cc_report 14:41:00 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1204 14:41:00 INFO - PROCESS | 1666 | __end_cc_report 14:41:00 INFO - PROCESS | 1666 | __startTimestamp1458942060727__endTimestamp 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | ------- Summary: start ------- 14:41:00 INFO - PROCESS | 1666 | Number of tests: 6 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5666.46 Median:5898.65 stddev:639.32 (10.8%) stddev-sans-first:595.44 14:41:00 INFO - PROCESS | 1666 | Values: 2636.0 3450.6 3471.0 3496.8 3532.3 5487.6 5600.3 5608.2 5632.9 5644.1 5569.1 5709.6 5714.5 5725.2 5763.9 5073.4 5122.8 5172.3 5176.3 5187.9 5076.1 5171.1 5279.1 5286.0 5291.7 5162.1 5184.6 5234.6 5246.4 5249.3 4277.2 5046.6 5070.6 5173.6 5200.6 5033.3 5081.6 5087.5 5100.7 5106.8 5547.3 5556.6 5566.7 5601.2 5613.6 6002.8 6046.5 6057.0 6064.8 6072.9 6072.6 6106.9 6118.1 6151.1 6235.5 5745.4 5745.5 5755.4 5765.1 5798.5 6164.7 6188.3 6218.6 6218.8 6272.0 5969.9 6048.8 6068.1 6108.2 6116.6 6102.3 6102.8 6136.1 6192.7 6209.1 6107.5 6114.5 6136.7 6145.9 6147.0 6136.9 6162.7 6163.8 6164.5 6164.8 4767.0 4829.2 4843.8 4868.7 4901.2 4320.6 4330.2 4353.7 4371.6 4379.0 5614.4 5617.1 5622.2 5630.5 5665.4 6073.7 6123.0 6160.9 6192.8 6201.7 5606.8 5609.9 5620.8 5657.0 5672.0 5302.8 5305.3 5316.1 5341.4 5385.0 6132.8 6211.4 6260.0 6265.9 6301.1 6168.4 6177.0 6180.7 6194.6 6226.9 6235.0 6237.9 6241.8 6257.8 6265.5 5953.1 6060.5 6129.8 6142.9 6143.4 5982.6 6138.6 6169.9 6191.0 6213.2 5875.6 6054.1 6067.9 6073.0 6093.4 5994.8 6025.5 6062.2 6088.6 6138.1 5886.6 5898.6 5906.2 5928.6 5942.0 5777.0 5936.1 5953.7 5964.5 5973.9 5619.2 5727.7 5746.7 5836.6 5910.6 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:60471.31 Median:35753.05 stddev:123534.97 (345.5%) stddev-sans-first:123799.43 14:41:00 INFO - PROCESS | 1666 | Values: 491.1 577.9 578.8 585.9 637.8 24588.0 30870.9 30874.4 30907.0 38114.0 31877.4 43266.7 43420.0 43618.0 43753.6 9244.3 9481.1 9500.3 9503.8 9523.9 9273.5 9421.9 9430.5 9431.2 9442.4 7512.5 9372.7 9549.6 9555.5 9585.5 9448.1 9548.2 9556.2 9559.7 9566.4 9485.3 9616.2 9616.9 9627.9 9634.0 41539.8 41572.8 42015.6 42077.6 42166.4 3236.5 3240.4 3394.4 3466.5 3467.9 28139.2 28309.4 28593.9 28633.0 29036.0 2748.1 2780.1 2787.0 2815.4 2927.3 497261.0 497876.0 498971.0 499889.0 500442.0 66657.7 67042.7 67320.0 67432.0 67436.7 72001.6 75357.0 76453.6 76544.2 76587.0 16909.7 17092.9 17144.7 17154.7 17207.2 11447.9 12652.2 13012.8 13056.1 13065.5 21464.6 21765.6 21906.0 22298.4 22378.7 8597.5 8755.5 8809.4 8818.3 8891.9 874.9 888.3 982.6 1109.8 1152.9 24398.4 28705.9 29437.9 29781.9 29947.9 1064.4 1159.8 1164.0 1172.2 1178.3 12098.3 14962.5 15046.1 15375.5 15656.2 539757.0 540946.0 543138.0 547160.0 547657.0 50380.0 60072.8 60631.0 60673.4 60759.7 1269.6 1355.3 1426.1 1447.4 1491.5 28524.0 28743.7 28778.0 28961.3 29146.4 46241.0 46771.3 47133.8 47172.8 47214.8 315523.0 317108.3 317745.0 317780.0 319148.0 29319.4 32834.7 33585.7 33792.7 34142.7 42000.9 42634.4 42709.8 42840.6 43502.6 34668.8 34971.8 35530.8 35711.1 35788.3 32464.7 34321.8 35574.3 35804.5 36794.4 35693.6 35717.8 35904.0 36029.2 36579.8 30889.5 31699.5 31839.5 31882.7 31958.8 19833.9 23612.0 23709.6 23841.2 24040.8 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:33100.46 Median:24244.38 stddev:100469.09 (414.4%) stddev-sans-first:100720.75 14:41:00 INFO - PROCESS | 1666 | Values: 303.3 308.6 360.4 369.5 369.5 19246.0 19698.5 19736.5 21122.2 21144.9 19165.0 19609.1 20396.5 20459.6 20502.5 5586.1 5739.3 5790.7 5792.5 5796.4 4158.6 4281.9 4365.5 4368.5 5852.0 6047.3 6356.8 6361.1 6366.6 6373.2 6156.4 6337.4 6429.7 6442.1 6453.6 3740.1 5242.1 5501.6 5526.4 5540.5 23359.5 23926.4 24117.9 24227.9 24260.9 2044.4 2121.3 2196.2 2379.4 2416.3 13902.7 14114.7 14204.8 14272.6 14649.4 1652.7 1757.7 1772.7 1791.7 1865.0 86035.3 89649.0 91688.4 93033.0 94489.0 9903.2 10034.1 10266.5 10389.9 10534.4 12553.6 12599.6 12610.4 12627.2 12634.8 6858.8 8220.3 8412.6 8512.7 8522.0 8705.3 8719.6 8730.6 8845.6 8848.5 4923.5 6002.4 6009.3 6016.2 6040.5 1505.1 1521.3 1692.5 1762.7 1796.1 937.4 972.6 1044.3 1069.6 1079.0 19642.8 20348.5 20614.3 20834.6 20960.3 957.9 972.1 990.9 995.4 1083.0 10907.5 11201.9 11227.8 11232.4 11233.9 599360.0 600233.0 605570.0 618502.0 628253.0 98060.5 98423.0 100328.0 101936.0 102248.5 953.7 993.9 998.0 1002.9 1006.8 15550.3 15778.2 18248.2 18249.8 18379.9 43018.0 43506.1 43562.6 43732.6 44824.8 63010.0 63203.0 63757.0 63872.4 64281.0 7606.4 7622.0 7670.0 7751.7 7945.5 12372.1 12699.5 12914.0 13032.4 13062.7 10984.1 11303.9 11360.4 11450.4 11458.5 10706.8 10745.4 10818.4 10890.3 11166.8 11064.8 11279.9 11286.3 11554.5 11736.4 7539.3 7761.1 7791.7 7803.4 8007.9 9433.2 10889.0 11205.6 11442.8 11450.3 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6066.41 Median:5198.77 stddev:3187.36 (61.3%) stddev-sans-first:3177.44 14:41:00 INFO - PROCESS | 1666 | Values: 1453.7 1593.7 1634.5 1896.8 2006.5 7970.2 8646.2 8797.3 8809.4 8841.2 8525.0 8791.4 8799.0 8825.8 8828.4 2467.0 2469.1 2469.7 2499.6 2499.6 2428.0 2517.5 2517.9 2527.5 2532.2 2388.4 2400.2 2432.4 2435.3 2436.3 2476.3 2491.9 2504.9 2506.5 2512.6 2115.9 2443.4 2482.3 2483.9 2528.5 8679.8 8724.0 8736.5 8744.8 8756.0 5380.1 5542.6 5551.3 5571.3 5590.6 3467.9 3540.6 3610.4 3616.0 3620.0 1051.6 1055.5 1061.4 1065.4 1072.9 11945.0 11959.0 11976.8 11977.9 12012.8 4846.8 4856.3 4879.8 4975.1 4984.5 10149.3 10159.5 10160.3 10163.2 10180.4 5513.3 5543.9 5552.8 5568.6 5578.0 4446.8 4610.4 4855.3 5001.1 5017.5 2798.1 3792.8 3850.6 3893.3 3900.0 1171.4 1328.0 1336.9 1348.1 1354.5 1027.0 1041.0 1172.1 1262.6 1406.0 7933.7 7976.7 8046.7 8047.6 8065.2 1190.9 1201.4 1215.4 1230.4 1235.5 6143.1 6164.8 6212.8 6239.7 6258.2 10362.5 10902.9 10938.4 10945.7 10949.3 10069.1 10663.3 10671.5 10719.0 10797.0 7388.0 7819.9 8174.8 8279.3 8308.8 7963.7 8002.0 8029.4 8091.9 8127.6 9224.3 9446.0 9478.1 9485.5 9583.9 9685.6 9700.5 9733.4 9987.6 10172.0 7571.4 7605.2 7638.6 7722.3 7724.6 8240.1 8269.2 8316.8 8347.1 8360.9 6235.3 7444.1 7562.1 7685.6 7724.5 7111.8 7283.7 7322.3 7332.9 7334.8 7703.6 7742.7 7750.8 7766.4 7776.5 6911.1 6917.1 7025.6 7031.9 7037.4 7051.3 7120.5 7130.9 7134.6 7134.9 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5632.17 Median:6487.82 stddev:1816.35 (28.0%) stddev-sans-first:1776.30 14:41:00 INFO - PROCESS | 1666 | Values: 270.6 333.1 334.5 339.7 341.4 6390.4 6541.6 6594.3 6618.2 6620.6 6420.8 6491.6 6492.0 6500.4 6555.0 3727.7 4058.1 4777.5 4901.6 4927.8 4625.9 4878.4 4885.9 4886.9 4891.1 4794.5 4817.7 4824.0 4827.2 4830.5 4572.0 4662.3 4815.3 4835.8 4850.6 4101.3 4125.7 4141.0 4151.2 4151.5 5624.7 5706.3 6214.8 6217.6 6227.8 4529.0 4701.9 5262.2 5495.5 5626.5 6889.4 6889.4 6895.6 6897.2 6897.2 3724.3 4313.7 4547.9 4548.6 4575.1 6151.8 7227.1 7236.8 7276.0 7379.4 4574.6 4585.5 4595.7 4597.9 4606.8 4648.2 4672.1 4674.9 4687.8 4689.0 4714.3 5461.3 5515.3 5520.6 5543.6 6652.9 6898.7 6938.4 6958.7 6973.3 1449.4 1490.3 1584.3 1609.3 1620.6 968.0 1015.6 1022.9 1042.3 1043.7 5316.5 6205.7 6320.9 6412.8 6512.9 7262.6 7267.2 7270.3 7271.0 7279.1 6487.8 6492.4 6500.3 6518.6 6533.2 3791.3 3827.5 3847.4 3852.5 3858.9 7236.9 7482.1 7558.9 7569.4 7585.3 7409.6 7451.5 7465.5 7469.8 7494.2 6154.4 6487.9 7133.6 7517.3 7538.4 6029.9 7027.5 7207.4 7212.0 7222.4 6770.4 7119.1 7126.2 7132.0 7138.3 7533.5 7533.9 7553.7 7563.8 7566.2 4266.5 4599.9 4601.7 4604.8 4625.1 6850.0 7169.5 7194.2 7208.4 7214.7 5643.0 6653.5 6970.4 6989.5 7057.0 6788.0 6973.7 7022.0 7046.1 7049.1 6857.3 6870.5 6873.9 6876.1 6902.3 6097.7 6664.8 7017.5 7020.1 7024.0 6599.1 6628.0 6743.2 6800.8 6850.9 14:41:00 INFO - PROCESS | 1666 | 14:41:00 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18368.21 Median:616.95 stddev:25855.73 (4190.9%) stddev-sans-first:25893.93 14:41:00 INFO - PROCESS | 1666 | Values: 624.6 688.7 723.7 747.6 756.3 14647.8 14817.3 14832.4 14835.9 14853.9 13606.7 13678.6 13679.2 13688.0 13703.7 735.4 893.1 899.5 922.3 927.4 901.8 909.3 911.9 914.0 916.8 968.6 970.1 972.2 973.0 974.5 764.3 942.6 962.3 966.5 969.5 722.8 725.5 727.6 727.6 728.3 14120.0 14348.1 14551.4 14605.3 14623.6 12220.7 12409.1 12521.6 12693.0 12750.4 9944.4 10005.7 10034.9 10038.9 10379.3 3466.5 3499.1 3539.7 3543.5 3612.1 82958.6 84189.6 84526.2 84651.0 84702.0 9264.0 9447.4 9521.8 9531.4 9744.3 21571.0 21580.4 21582.9 21588.2 21599.7 6190.2 7146.3 7261.1 7261.3 7469.6 3946.9 3976.3 4001.8 4008.3 4043.7 3548.8 3582.6 3582.9 3590.7 3598.4 607.3 610.5 624.5 626.1 637.0 501.1 558.4 615.4 616.7 617.2 8006.7 8255.6 8295.9 8327.8 8347.2 582.5 583.5 590.4 604.2 616.2 3375.3 3586.4 3712.7 3751.5 3915.9 74468.6 87787.0 87919.6 89011.6 89646.6 77316.0 77675.6 80303.0 80760.2 81004.0 70570.3 71081.6 72146.3 72531.6 73596.0 8567.7 8569.8 8618.7 8760.8 8849.9 48768.0 48983.0 49810.3 51347.7 51752.7 69761.7 70835.6 70977.6 71254.0 73103.6 10795.6 11134.0 11163.6 11265.0 11417.9 11890.6 12043.5 12292.6 12317.0 12430.6 11495.8 11496.0 11626.9 11861.0 12001.2 10898.7 11484.7 11491.4 11491.5 11727.8 10828.2 11314.8 11427.3 11719.6 12250.9 9329.7 9346.3 9388.8 9821.5 10036.4 7848.8 8562.8 8979.4 9112.8 9153.9 14:41:00 INFO - PROCESS | 1666 | -------- Summary: end -------- 14:41:00 INFO - PROCESS | 1666 | 14:41:01 INFO - TEST-INFO | 1666: exit 0 14:41:01 INFO - TEST-OK | dromaeo_css | took 1113194ms 14:41:01 INFO - TEST-START | kraken 14:41:01 INFO - operating with platform_type : mac_ 14:41:01 INFO - Initialising browser for kraken test... 14:41:01 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpaesKa6/profile http://localhost:49270/getInfo.html) 14:41:03 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 14:41:03 INFO - PROCESS | 1674 | colorDepth:24 14:41:03 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 14:41:03 INFO - PROCESS | 1674 | __metrics 14:41:03 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:41:03 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:41:04 INFO - TEST-INFO | 1674: exit 0 14:41:04 INFO - Browser initialized. 14:41:04 INFO - Running cycle 1/1 for kraken test... 14:41:04 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpaesKa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:16 INFO - PROCESS | 1676 | RSS: Main: 244215808 14:41:16 INFO - PROCESS | 1676 | 14:41:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:19 INFO - PROCESS | 1676 | RSS: Main: 290238464 14:41:19 INFO - PROCESS | 1676 | 14:41:22 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 14:41:23 INFO - PROCESS | 1676 | RSS: Main: 300707840 14:41:23 INFO - PROCESS | 1676 | 14:41:26 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 14:41:26 INFO - PROCESS | 1676 | RSS: Main: 284938240 14:41:26 INFO - PROCESS | 1676 | 14:41:28 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 14:41:29 INFO - PROCESS | 1676 | RSS: Main: 287629312 14:41:29 INFO - PROCESS | 1676 | 14:41:31 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:32 INFO - PROCESS | 1676 | RSS: Main: 288604160 14:41:32 INFO - PROCESS | 1676 | 14:41:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:35 INFO - PROCESS | 1676 | RSS: Main: 288980992 14:41:35 INFO - PROCESS | 1676 | 14:41:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:39 INFO - PROCESS | 1676 | RSS: Main: 289202176 14:41:39 INFO - PROCESS | 1676 | 14:41:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 14:41:42 INFO - PROCESS | 1676 | RSS: Main: 289452032 14:41:42 INFO - PROCESS | 1676 | 14:41:44 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:44 INFO - PROCESS | 1676 | RSS: Main: 324911104 14:41:44 INFO - PROCESS | 1676 | 14:41:46 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:47 INFO - PROCESS | 1676 | RSS: Main: 323768320 14:41:47 INFO - PROCESS | 1676 | 14:41:49 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:50 INFO - PROCESS | 1676 | RSS: Main: 330797056 14:41:50 INFO - PROCESS | 1676 | 14:41:52 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:53 INFO - PROCESS | 1676 | RSS: Main: 331698176 14:41:53 INFO - PROCESS | 1676 | 14:41:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:56 INFO - PROCESS | 1676 | RSS: Main: 331730944 14:41:56 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 14:41:58 INFO - PROCESS | 1676 | RSS: Main: 394334208 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | __start_tp_report 14:41:58 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 14:41:58 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 14:41:58 INFO - PROCESS | 1676 | |i|pagename|runs| 14:41:58 INFO - PROCESS | 1676 | |0;ai-astar;117;155;164;111;113;112;116;111;112;111 14:41:58 INFO - PROCESS | 1676 | |1;audio-beat-detection;159;122;145;181;112;189;172;148;160;119 14:41:58 INFO - PROCESS | 1676 | |2;audio-dft;184;185;186;187;186;182;183;180;180;182 14:41:58 INFO - PROCESS | 1676 | |3;audio-fft;64;100;120;107;55;57;56;82;85;78 14:41:58 INFO - PROCESS | 1676 | |4;audio-oscillator;94;96;131;79;80;83;118;79;80;121 14:41:58 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;89;129;90;88;89;86;91;87;90;85 14:41:58 INFO - PROCESS | 1676 | |6;imaging-darkroom;94;94;106;150;108;94;94;95;93;95 14:41:58 INFO - PROCESS | 1676 | |7;imaging-desaturate;91;136;135;71;134;135;92;91;91;89 14:41:58 INFO - PROCESS | 1676 | |8;json-parse-financial;57;55;54;53;54;54;55;66;54;53 14:41:58 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;67;74;66;74;70;69;69;68;66;67 14:41:58 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;84;83;84;84;83;83;83;81;83;82 14:41:58 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;121;122;123;119;134;127;121;127;121;120 14:41:58 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;139;130;141;138;139;130;138;138;137;141 14:41:58 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;68;67;66;66;65 14:41:58 INFO - PROCESS | 1676 | __end_tp_report 14:41:58 INFO - PROCESS | 1676 | __start_cc_report 14:41:58 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1239 14:41:58 INFO - PROCESS | 1676 | __end_cc_report 14:41:58 INFO - PROCESS | 1676 | __startTimestamp1458942118269__endTimestamp 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | ------- Summary: start ------- 14:41:58 INFO - PROCESS | 1676 | Number of tests: 14 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:122.20 Median:114.50 stddev:19.88 (17.4%) stddev-sans-first:21.00 14:41:58 INFO - PROCESS | 1676 | Values: 117.0 155.0 164.0 111.0 113.0 112.0 116.0 111.0 112.0 111.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:159.50 stddev:26.58 (16.7%) stddev-sans-first:28.03 14:41:58 INFO - PROCESS | 1676 | Values: 159.0 122.0 145.0 181.0 112.0 189.0 172.0 148.0 160.0 119.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.50 stddev:2.51 (1.4%) stddev-sans-first:2.65 14:41:58 INFO - PROCESS | 1676 | Values: 184.0 185.0 186.0 187.0 186.0 182.0 183.0 180.0 180.0 182.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:80.40 Median:60.50 stddev:22.96 (38.0%) stddev-sans-first:23.58 14:41:58 INFO - PROCESS | 1676 | Values: 64.0 100.0 120.0 107.0 55.0 57.0 56.0 82.0 85.0 78.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:80.00 stddev:19.99 (25.0%) stddev-sans-first:21.19 14:41:58 INFO - PROCESS | 1676 | Values: 94.0 96.0 131.0 79.0 80.0 83.0 118.0 79.0 80.0 121.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:92.40 Median:89.00 stddev:13.00 (14.6%) stddev-sans-first:13.73 14:41:58 INFO - PROCESS | 1676 | Values: 89.0 129.0 90.0 88.0 89.0 86.0 91.0 87.0 90.0 85.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:94.00 stddev:17.61 (18.7%) stddev-sans-first:18.42 14:41:58 INFO - PROCESS | 1676 | Values: 94.0 94.0 106.0 150.0 108.0 94.0 94.0 95.0 93.0 95.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:106.50 Median:90.00 stddev:25.27 (28.1%) stddev-sans-first:26.18 14:41:58 INFO - PROCESS | 1676 | Values: 91.0 136.0 135.0 71.0 134.0 135.0 92.0 91.0 91.0 89.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.50 stddev:3.87 (7.1%) stddev-sans-first:4.06 14:41:58 INFO - PROCESS | 1676 | Values: 57.0 55.0 54.0 53.0 54.0 54.0 55.0 66.0 54.0 53.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:2.94 (4.3%) stddev-sans-first:3.03 14:41:58 INFO - PROCESS | 1676 | Values: 67.0 74.0 66.0 74.0 70.0 69.0 69.0 68.0 66.0 67.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.94 (1.1%) stddev-sans-first:0.93 14:41:58 INFO - PROCESS | 1676 | Values: 84.0 83.0 84.0 84.0 83.0 83.0 83.0 81.0 83.0 82.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:122.50 stddev:4.58 (3.7%) stddev-sans-first:4.76 14:41:58 INFO - PROCESS | 1676 | Values: 121.0 122.0 123.0 119.0 134.0 127.0 121.0 127.0 121.0 120.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.10 Median:138.50 stddev:3.96 (2.9%) stddev-sans-first:4.14 14:41:58 INFO - PROCESS | 1676 | Values: 139.0 130.0 141.0 138.0 139.0 130.0 138.0 138.0 137.0 141.0 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 14:41:58 INFO - PROCESS | 1676 | Values: 67.0 67.0 66.0 67.0 67.0 68.0 67.0 66.0 66.0 65.0 14:41:58 INFO - PROCESS | 1676 | -------- Summary: end -------- 14:41:58 INFO - PROCESS | 1676 | 14:41:58 INFO - TEST-INFO | 1676: exit 0 14:41:59 INFO - TEST-OK | kraken | took 57707ms 14:41:59 INFO - SUITE-END | took 1170s 14:41:59 INFO - Completed test suite (00:19:31) 14:41:59 INFO - javascript benchmark 14:41:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2635.9868200659, 3450.603180634226, 3471.0, 3496.807675577843, 3532.2582257725876, 5487.5609951203905, 5600.299962504687, 5608.2428872102255, 5632.943670563293, 5644.125160600109, 5569.053260945639, 5709.628874123179, 5714.542836573075, 5725.169850371693, 5763.855903602402, 5073.391193056838, 5122.795088196468, 5172.27588137661, 5176.301199338088, 5187.896242075156, 5076.086304465213, 5171.09505836479, 5279.128943724281, 5286.04851126797, 5291.735413229342, 5162.096633089194, 5184.585233181337, 5234.58123350133, 5246.422893481714, 5249.291345668343, 4277.2087163874785, 5046.621503387224, 5070.594352451795, 5173.637845350827, 5200.609954253446, 5033.299116817152, 5081.644284900059, 5087.542121209072, 5100.69395836251, 5106.795728170869, 5547.3343198816, 5556.611037227396, 5566.721663916828, 5601.215829783833, 5613.578981576357, 6002.759889604411, 6046.469991446036, 6057.011860859147, 6064.773978780771, 6072.886587673032, 6072.635641861502, 6106.946476819281, 6118.082287656843, 6151.077338399231, 6235.469985051276, 5745.425457454263, 5745.511631511285, 5755.395683453261, 5765.077587586008, 5798.507126894219, 6164.660943648053, 6188.319284878659, 6218.626882387071, 6218.81343559694, 6272.0, 5969.940300597025, 6048.818535443944, 6068.120122582201, 6108.17539632144, 6116.571839971249, 6102.267727872683, 6102.847428814315, 6136.110264011693, 6192.659403732748, 6209.130721698965, 6107.480864126599, 6114.510272098639, 6136.693165341715, 6145.877082458326, 6147.047207682816, 6136.858522390323, 6162.661053642003, 6163.84590385244, 6164.4760195383, 6164.7842325518395, 4766.976165119152, 4829.154897892855, 4843.830465933675, 4868.683535570177, 4901.166801643729, 4320.567943205654, 4330.155619654201, 4353.695241333076, 4371.628411584988, 4379.014721687595, 5614.438556144353, 5617.101263797773, 5622.184783206412, 5630.5495560355075, 5665.405132461115, 6073.665948372882, 6122.977604208209, 6160.907586386208, 6192.783252586138, 6201.658908759971, 5606.831795046155, 5609.859753506195, 5620.831375058755, 5657.0, 5672.007398705293, 5302.761375738101, 5305.257263983045, 5316.0696878046965, 5341.385740639798, 5384.9730751346, 6132.783850801441, 6211.409916057877, 6260.029695397221, 6265.8746825063245, 6301.0863424804065, 6168.444839964424, 6176.969115154396, 6180.721867515883, 6194.5973511721595, 6226.875462490815, 6235.033569796688, 6237.937620623918, 6241.78153764616, 6257.8122656318565, 6265.498760099273, 5953.10703394477, 6060.454559089703, 6129.756146212572, 6142.877142457215, 6143.419763699168, 5982.551308651781, 6138.572327483795, 6169.907451388143, 6191.0, 6213.2233470816145, 5875.618084824473, 6054.122152287981, 6067.878642427215, 6073.0283154695035, 6093.390660933871, 5994.820155395345, 6025.548083893813, 6062.242219722535, 6088.6042407243385, 6138.109974053648, 5886.558508111823, 5898.64608123514, 5906.173135761082, 5928.614640048383, 5942.019566771434, 5776.971115144565, 5936.079907614327, 5953.7023148843255, 5964.522838173022, 5973.850653733692, 5619.185218143428, 5727.713614319351, 5746.741396637078, 5836.591438599427, 5910.556708246812], "unit": "score", "name": "dojo.html", "value": 5624.728373817447}, {"lowerIsBetter": false, "replicates": [491.0620714435429, 577.9162021506882, 578.7800635758412, 585.9346812717379, 637.7544645311557, 24588.0, 30870.919517816827, 30874.382512349766, 30907.0, 38114.0, 31877.36245275093, 43266.70199894001, 43420.0, 43618.0, 43753.56246437535, 9244.260459163268, 9481.146696797286, 9500.28747843911, 9503.762405939873, 9523.857142142873, 9273.489958052338, 9421.858672119924, 9430.528473576329, 9431.151196392324, 9442.386244894094, 7512.549247045167, 9372.67195648149, 9549.61801527938, 9555.522223888813, 9585.472798996052, 9448.149666530011, 9548.18840398567, 9556.187724043464, 9559.665411710557, 9566.37818541796, 9485.288603354707, 9616.23070154386, 9616.855747163798, 9627.903720962771, 9634.0, 41539.7923010386, 41572.79213603943, 42015.57984420147, 42077.57922420767, 42166.367504487454, 3236.4983427568764, 3240.4329242382723, 3394.372041172366, 3466.480027995796, 3467.8959631211105, 28139.155825325273, 28309.409492410756, 28593.857030714713, 28633.0, 29036.0, 2748.0656576763795, 2780.06867699321, 2787.0, 2815.3665425279355, 2927.3044446322033, 497261.0, 497876.0212397866, 498970.9999999964, 499889.0, 500442.0, 66657.6667116671, 67042.66478667576, 67319.99020014703, 67432.0, 67436.66281668658, 72001.63999180075, 75357.0, 76453.61773191098, 76544.23455765483, 76587.0, 16909.7463538047, 17092.91453542749, 17144.657106857794, 17154.742678859828, 17207.225674844663, 11447.885521144683, 12652.240865548096, 13012.804807927889, 13056.106864504594, 13065.477380904656, 21464.57070858574, 21765.564688706454, 21906.0, 22298.44253893633, 22378.664320035212, 8597.52713600758, 8755.518446485505, 8809.414305424956, 8818.33862460318, 8891.866622000674, 874.9212570868652, 888.3071204460531, 982.5824024789435, 1109.839073334362, 1152.913531485142, 24398.390040249134, 28705.856470717932, 29437.852810736236, 29781.851090744407, 29947.850260748557, 1064.3932958213898, 1159.8260260960924, 1163.959261425863, 1172.1677608897778, 1178.3106882473849, 12098.274103553815, 14962.476313328982, 15046.097234165765, 15375.461858834888, 15656.217189140498, 539757.0, 540946.0, 543138.0, 547160.0, 547657.0, 50380.0, 60072.798544028876, 60631.0, 60673.39326606766, 60759.6962015196, 1269.5873841001712, 1355.2817006986313, 1426.1371870018697, 1447.4210315873524, 1491.4854375240525, 28524.0, 28743.712562874105, 28777.992770252942, 28961.275968100967, 29146.417071658023, 46241.0, 46771.29843052289, 47133.76433117812, 47172.82067948329, 47214.76392618015, 315523.0, 317108.31566737074, 317745.0, 317780.0, 319148.0, 29319.41361172722, 32834.67165328316, 33585.664143358255, 33792.662073379935, 34142.658573413944, 42000.949976250835, 42634.36048459337, 42709.78645106754, 42840.57159428366, 43502.56497434985, 34668.82665586656, 34971.825140874134, 35530.822345888104, 35711.10722231965, 35788.28423431465, 32464.675353246166, 34321.82839085789, 35574.28851423009, 35804.4629330555, 36794.448083279305, 35693.64306357007, 35717.82141089278, 35904.0, 36029.166230568844, 36579.817100914326, 30889.536656949713, 31699.52450713195, 31839.522407163447, 31882.68117318797, 31958.840205799752, 19833.900830495757, 23612.0, 23709.644355334338, 23841.165559205343, 24040.75959240385], "unit": "score", "name": "ext.html", "value": 19486.598159816047}, {"lowerIsBetter": false, "replicates": [303.3220751620129, 308.56338281331915, 360.41972424396715, 369.5067085440936, 369.5417682074229, 19246.0, 19698.507537311576, 19736.474346176878, 21122.15511379543, 21144.8942755286, 19165.0, 19609.11758970846, 20396.490087747814, 20459.590808183828, 20502.487437814063, 5586.10622300432, 5739.253896993385, 5790.652560846363, 5792.536597072245, 5796.362400135981, 4158.563350848162, 4281.892952676192, 4365.454318210223, 4368.453943257093, 5851.970740146293, 6047.274327080757, 6356.84107897304, 6361.077643741654, 6366.618002919817, 6373.203349581302, 6156.415140561662, 6337.429631333179, 6429.678516074225, 6442.098106265126, 6453.645049522274, 3740.1023754299044, 5242.135047717122, 5501.642393244426, 5526.392096869341, 5540.50135487804, 23359.532809343717, 23926.401839953967, 24117.87941060301, 24227.87886060576, 24260.878695606585, 2044.4071219346372, 2121.2999710095633, 2196.2203417786777, 2379.4170428245193, 2416.2751174647537, 13902.652433689138, 14114.717705645933, 14204.786928196085, 14272.571822845228, 14649.414023439049, 1652.6859896619603, 1757.736339549078, 1772.7163653815458, 1791.7133258678548, 1864.962700745991, 86035.27929441439, 89649.0, 91688.44015247276, 93033.0, 94488.99999999932, 9903.207743380512, 10034.147097496794, 10266.538005789758, 10389.896101039045, 10534.36793792375, 12553.623391298275, 12599.559015434415, 12610.369481525888, 12627.242365458102, 12634.81047784284, 6858.759943401957, 8220.260176584135, 8412.579371031425, 8512.74461766148, 8521.957390213132, 8705.260052895448, 8719.564021798884, 8730.563471826383, 8845.646174152962, 8848.46909185451, 4923.532264434873, 6002.369751176151, 6009.308929473079, 6016.217891674054, 6040.546958978006, 1505.0518173550593, 1521.2849960518538, 1692.4668729350215, 1762.7091529897423, 1796.1378538301688, 937.3625934364561, 972.5672075926145, 1044.2951008069522, 1069.5828626835541, 1078.9892101078888, 19642.803571964098, 20348.49128771763, 20614.278500252418, 20834.58330833375, 20960.266390676254, 957.9233661307079, 972.1202311907734, 990.8612794208816, 995.3629677006577, 1082.9620963266248, 10907.509162087725, 11201.887981120248, 11227.831582526269, 11232.382218978035, 11233.933675814968, 599360.0031999812, 600233.0, 605570.0, 618502.0, 628253.0, 98060.50969745105, 98422.99999999857, 100328.0, 101936.0, 102248.48875755722, 953.7186529973675, 993.8608594796734, 997.9650712225183, 1002.884668263159, 1006.7986402719486, 15550.300236489158, 15778.211089445711, 18248.17883195286, 18249.792854219435, 18379.897206167672, 43018.0, 43506.129877402906, 43562.564374355854, 43732.56267437285, 44824.77587612041, 63010.0, 63203.0, 63757.04364434444, 63872.36127638664, 64281.0, 7606.429517786078, 7622.047244094489, 7670.0, 7751.728689495841, 7945.523268603903, 12372.07209459312, 12699.492020319083, 12914.0, 13032.41354139085, 13062.673433163867, 10984.06635435965, 11303.92612701792, 11360.431978401211, 11450.427478625868, 11458.541658333574, 10706.839397408889, 10745.409002504937, 10818.404987725751, 10890.346579205274, 11166.776664466828, 11064.778704426028, 11279.943600281946, 11286.322820630789, 11554.537818487503, 11736.354500502213, 7539.283768042027, 7761.107472640719, 7791.727289544839, 7803.375729941477, 8007.91992080095, 9433.151016408281, 10889.0, 11205.60780372683, 11442.771144576895, 11450.255733377304], "unit": "score", "name": "jquery.html", "value": 9267.249024996909}, {"lowerIsBetter": false, "replicates": [1453.6729235921925, 1593.7450007998718, 1634.4851371817872, 1896.819802118799, 2006.5084054406673, 7970.202979702027, 8646.221840034395, 8797.252233560155, 8809.427387219843, 8841.248493878013, 8524.957375213131, 8791.384603077771, 8799.0, 8825.823483530325, 8828.426152300097, 2466.976204874975, 2469.148143890364, 2469.6912885889265, 2499.550080985422, 2499.5875680512695, 2427.9514409711796, 2517.5216708825265, 2517.924462266135, 2527.545041892459, 2532.227670560478, 2388.379021454417, 2400.219928523228, 2432.3675844280438, 2435.257246539805, 2436.2691192642224, 2476.3437689012335, 2491.9377015574573, 2504.9479218727997, 2506.5112303100905, 2512.623106534016, 2115.883626400547, 2443.3525115844313, 2482.2801387597574, 2483.900643974257, 2528.469021505486, 8679.826403471896, 8724.0, 8736.475811451333, 8744.825103497895, 8755.956220218923, 5380.058489764315, 5542.584306177053, 5551.306086739158, 5571.275734154575, 5590.5527557795685, 3467.8959631211105, 3540.5751309842985, 3610.3824727072924, 3615.9819200903826, 3620.0406892173596, 1051.5636011055403, 1055.5039131608132, 1061.376094575301, 1065.387402243713, 1072.8980746829038, 11944.984676302525, 11958.999999999913, 11976.820347694791, 11977.94011029948, 12012.819807702805, 4846.7818948147415, 4856.344393506902, 4879.804807807648, 4975.0796102721115, 4984.526469985346, 10149.289549731595, 10159.542820573091, 10160.288779785344, 10163.18694504438, 10180.389176649276, 5513.283273174462, 5543.944560554342, 5552.7778888843995, 5568.554515638739, 5578.023845826964, 4446.799894004777, 4610.354550362952, 4855.344528488679, 5001.124803159432, 5017.4731653175895, 2798.0766347105405, 3792.791396473165, 3850.6330252760426, 3893.299206142865, 3899.991504375249, 1171.4142928535732, 1327.9535216267384, 1336.87968082873, 1348.083303353729, 1354.4852955876704, 1027.0448482910815, 1040.953157107932, 1172.1443346357207, 1262.6085913366885, 1405.9859401406059, 7933.722319718782, 7976.680932762741, 8046.678132874737, 8047.557384343917, 8065.193480652005, 1190.9166358354832, 1201.4173126033866, 1215.440897187286, 1230.39095647655, 1235.5490246060303, 6143.140856217124, 6164.7842325518395, 6212.751489940442, 6239.688015599202, 6258.155149054819, 10362.481875906175, 10902.890971090346, 10938.398388088732, 10945.671629851116, 10949.343039417661, 10069.093781559548, 10663.253572250023, 10671.46642667879, 10719.0, 10797.0, 7388.0, 7819.944307518526, 8174.754757357289, 8279.254867061993, 8308.83382332362, 7963.681452742057, 8002.0, 8029.4379393441895, 8091.878621820795, 8127.593620319079, 9224.308176886627, 9446.0, 9478.099580539838, 9485.478298693362, 9583.945765965598, 9685.564149613425, 9700.5149742514, 9733.367331123454, 9987.60049598008, 10172.0, 7571.432142589438, 7605.163432022584, 7638.579878106758, 7722.266384693445, 7724.6137693114, 8240.1347858474, 8269.173082691683, 8316.833663326579, 8347.123552027193, 8360.87458688108, 6235.314115447388, 7444.143923448656, 7562.092548893947, 7685.615719213905, 7724.497907635986, 7111.751088711871, 7283.672234749555, 7322.2677732228485, 7332.926670733438, 7334.816629584303, 7703.614819259126, 7742.729004484816, 7750.806229844299, 7766.378689704923, 7776.533407995538, 6911.101556797584, 6917.100776898971, 7025.6487175639995, 7031.929680703128, 7037.437005039687, 7051.330123638246, 7120.501564890408, 7130.857382852418, 7134.607596582237, 7134.892976605459], "unit": "score", "name": "mootools.html", "value": 4953.310479184163}, {"lowerIsBetter": false, "replicates": [270.56844333288404, 333.10727250967415, 334.46819556904524, 339.66373290442453, 341.4042495844751, 6390.424861762441, 6541.640209788466, 6594.274629790719, 6618.205815302158, 6620.569662971903, 6420.807375778722, 6491.610503369801, 6491.967540162304, 6500.414962653372, 6555.0, 3727.664510194082, 4058.127502586943, 4777.474477807438, 4901.558859702626, 4927.778249978742, 4625.884352891171, 4878.438979517366, 4885.853424397256, 4886.877828054292, 4891.14404979129, 4794.472608013116, 4817.686850354733, 4823.951760482403, 4827.203511420611, 4830.468648448667, 4572.039871626962, 4662.254039353687, 4815.3258543803895, 4835.806567737286, 4850.611951043908, 4101.343784994417, 4125.690573206992, 4140.958590414088, 4151.169766046803, 4151.46031015966, 5624.662520248758, 5706.28671416073, 6214.8135555933395, 6217.595856269328, 6227.844303892393, 4528.9547104528865, 4701.858944231679, 5262.184361423985, 5495.53287970519, 5626.521745651625, 6889.414399776025, 6889.448844092461, 6895.586264824076, 6897.172339319314, 6897.241303456616, 3724.348239058181, 4313.698041137121, 4547.931781023287, 4548.613367863735, 4575.062112266977, 6151.846203844851, 7227.1327440707455, 7236.769749142659, 7276.0, 7379.3727533159745, 4574.588287054181, 4585.495595484494, 4595.747233902168, 4597.931031034537, 4606.8157273708675, 4648.1865673507, 4672.08894265615, 4674.929876051794, 4687.7656117194, 4689.0, 4714.292856071548, 5461.344638643388, 5515.283013208337, 5520.641158324696, 5543.6396634218645, 6652.933470665328, 6898.724051037902, 6938.444924406035, 6958.721651133898, 6973.267806880306, 1449.4492093004592, 1490.2548725637182, 1584.255399962016, 1609.3321271672125, 1620.6110533472117, 968.0464742228899, 1015.6140666546665, 1022.8850552897378, 1042.2547878267076, 1043.7442826507402, 5316.548093412026, 6205.6586887721605, 6320.873582528324, 6412.775552855627, 6512.869742605121, 7262.636868156676, 7267.164276108209, 7270.272972702687, 7270.9636451817405, 7279.1265048194555, 6487.772927947593, 6492.35076492347, 6500.252470965805, 6518.608883466913, 6533.216014078341, 3791.279656865187, 3827.4641550182996, 3847.4228865670375, 3852.5184351956004, 3858.903527411781, 7236.855262894713, 7482.064741907262, 7558.941748155263, 7569.356604688553, 7585.279398457138, 7409.555426674417, 7451.478396512301, 7465.514741541782, 7469.775906722807, 7494.213107623621, 6154.446099850946, 6487.870242595027, 7133.573285342848, 7517.323440890346, 7538.3592394645975, 6029.944759666953, 7027.508074434741, 7207.387372073433, 7211.963940180265, 7222.422206223595, 6770.390664839991, 7119.1457025157315, 7126.180489243803, 7132.0, 7138.286171383028, 7533.54798712079, 7533.886991695019, 7553.7356192533, 7563.773086807405, 7566.205548417337, 4266.488021437447, 4599.93100103492, 4601.700889442175, 4604.792784324646, 4625.098105869458, 6850.0, 7169.533980291264, 7194.244604316471, 7208.423326134001, 7214.71141154348, 5642.971785141048, 6653.467722582279, 6970.442364610718, 6989.47578931572, 7057.0, 6787.966060169668, 6973.686184121625, 7022.0, 7046.1192350956135, 7049.08361912948, 6857.314268573103, 6870.519063665495, 6873.862522749417, 6876.106106206161, 6902.275261097512, 6097.74996125802, 6664.833379165366, 7017.5087743859485, 7020.052292940388, 7023.964880175567, 6599.109120268894, 6627.972664237051, 6743.15710536183, 6800.829979250559, 6850.9314906850295], "unit": "score", "name": "prototype.html", "value": 5024.243823461125}, {"lowerIsBetter": false, "replicates": [624.6158612453341, 688.707299397756, 723.7105157936828, 747.6373958630063, 756.2513112019103, 14647.780283295746, 14817.333220005099, 14832.406703731851, 14835.92582037091, 14853.851461485381, 13606.659833504142, 13678.589642310722, 13679.24764137972, 13688.0, 13703.725925481509, 735.3528894572769, 893.120276527623, 899.5232526760827, 922.349743430883, 927.3925578745899, 901.8331608652387, 909.3498148823589, 911.858661907402, 913.9900410046902, 916.8212198621271, 968.6173961285288, 970.1268858027761, 972.2027937091552, 973.0318333258382, 974.5273542331963, 764.2739397572301, 942.5993952570165, 962.2879069488528, 966.5312323523086, 969.5346233807742, 722.7759394587695, 725.542907967982, 727.6325455644866, 727.6434547071949, 728.279003786253, 14120.0, 14348.139111653334, 14551.417943282257, 14605.269736513239, 14623.561293161221, 12220.694482637917, 12409.131360804748, 12521.624351269476, 12692.984561235078, 12750.426230819636, 9944.403335799876, 10005.749856253578, 10034.89965100347, 10038.949805251, 10379.273450858444, 3466.5146879436898, 3499.0727457223857, 3539.7168226541817, 3543.5216245807, 3612.1330880588735, 82958.58520707418, 84189.57905210496, 84526.16633671291, 84651.0, 84702.0, 9264.027277135938, 9447.433154010781, 9521.809563808823, 9531.428114313163, 9744.31789774723, 21571.0, 21580.352589422342, 21582.89208553947, 21588.244411445838, 21599.67600485994, 6190.226221722285, 7146.32109949554, 7261.128664560287, 7261.329894124381, 7469.551826890404, 3946.940795888064, 3976.343903255988, 4001.7999100045463, 4008.2584721826556, 4043.6765058795227, 3548.8048157351595, 3582.5521809773777, 3582.946255806165, 3590.7306951978185, 3598.3702852000797, 607.271274470637, 610.4658423879106, 624.475440629864, 626.1077963901513, 636.9712913644523, 501.0830180769184, 558.4164548047219, 615.3753939751156, 616.740968793108, 617.1575799034375, 8006.719764808204, 8255.587220638945, 8295.917040829514, 8327.750167494985, 8347.165283471604, 582.5223316880117, 583.5011065538988, 590.4066413254651, 604.1843511259764, 616.2420223125581, 3375.29118885032, 3586.444101164324, 3712.7029837612927, 3751.512303400595, 3915.9216815663526, 74468.62765686137, 87787.0, 87919.56040219757, 89011.55494222487, 89646.55176724074, 77316.0, 77675.61162194266, 80303.0, 80760.19239807644, 81004.0, 70570.2942970574, 71081.57836843234, 72146.27853721396, 72531.6373418119, 73596.0, 8567.700130495403, 8569.785755356166, 8618.65525379003, 8760.824783504167, 8849.867251991354, 48768.02463950772, 48983.0, 49810.25284620661, 51347.74326128345, 51752.74123629358, 69761.65119174372, 70835.58328833498, 70977.64511177411, 71254.0, 73103.63448182725, 10795.6221532246, 11134.0, 11163.553457861919, 11265.0, 11417.885821141683, 11890.583829565923, 12043.458044387848, 12292.569760058355, 12317.0, 12430.564930227398, 11495.77008459843, 11496.0, 11626.895444932718, 11861.0, 12001.219920705125, 10898.727531811768, 11484.712882178012, 11491.425428728697, 11491.540338386705, 11727.76544469123, 10828.24202305831, 11314.830277546009, 11427.314361138026, 11719.589814356797, 12250.938745306217, 9329.72010839676, 9346.252299816135, 9388.76528086776, 9821.508924553887, 10036.447995360326, 7848.7645370638975, 8562.785930351542, 8979.371443998858, 9112.815334006536, 9153.908460915305], "unit": "score", "name": "yui.html", "value": 6884.529787241457}], "name": "dromaeo_css", "value": 7472.122158782506}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 155.0, 164.0, 111.0, 113.0, 112.0, 116.0, 111.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 122.2}, {"lowerIsBetter": true, "replicates": [159.0, 122.0, 145.0, 181.0, 112.0, 189.0, 172.0, 148.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 186.0, 187.0, 186.0, 182.0, 183.0, 180.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.5}, {"lowerIsBetter": true, "replicates": [64.0, 100.0, 120.0, 107.0, 55.0, 57.0, 56.0, 82.0, 85.0, 78.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 131.0, 79.0, 80.0, 83.0, 118.0, 79.0, 80.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 96.1}, {"lowerIsBetter": true, "replicates": [89.0, 129.0, 90.0, 88.0, 89.0, 86.0, 91.0, 87.0, 90.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 106.0, 150.0, 108.0, 94.0, 94.0, 95.0, 93.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 102.3}, {"lowerIsBetter": true, "replicates": [91.0, 136.0, 135.0, 71.0, 134.0, 135.0, 92.0, 91.0, 91.0, 89.0], "unit": "score", "name": "imaging-desaturate", "value": 106.5}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 54.0, 53.0, 54.0, 54.0, 55.0, 66.0, 54.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 74.0, 66.0, 74.0, 70.0, 69.0, 69.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 83.0, 83.0, 83.0, 81.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [121.0, 122.0, 123.0, 119.0, 134.0, 127.0, 121.0, 127.0, 121.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [139.0, 130.0, 141.0, 138.0, 139.0, 130.0, 138.0, 138.0, 137.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1468.7999999999997}]} 14:41:59 INFO - Return code: 0 14:41:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:41:59 ERROR - # TBPL SUCCESS # 14:41:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:59 INFO - 2016-03-25 14:41:59.613 screenresolution[1680:10075] starting screenresolution argv=screenresolution get 14:41:59 INFO - 2016-03-25 14:41:59.616 screenresolution[1680:10075] Display 0: 1600x1200x32@60 14:41:59 INFO - 2016-03-25 14:41:59.622 screenresolution[1681:10078] starting screenresolution argv=screenresolution list 14:41:59 INFO - Available Modes on Display 0 14:41:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:59 INFO - Intel Iris: 14:41:59 INFO - Chipset Model: Intel Iris 14:41:59 INFO - Type: GPU 14:41:59 INFO - Bus: Built-In 14:41:59 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:59 INFO - Vendor: Intel (0x8086) 14:41:59 INFO - Device ID: 0x0a2e 14:41:59 INFO - Revision ID: 0x0009 14:41:59 INFO - Displays: 14:41:59 INFO - Display: 14:41:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:59 INFO - Display Serial Number: 1600x1200 60 14:41:59 INFO - Main Display: Yes 14:41:59 INFO - Mirror: Off 14:41:59 INFO - Online: Yes 14:41:59 INFO - Rotation: Supported 14:41:59 INFO - Return code: 0 14:41:59 INFO - Running post-action listener: _resource_record_post_action 14:41:59 INFO - Running post-run listener: _resource_record_post_run 14:42:00 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34340352; Write bytes: 704977920; Read time: 367; Write time: 1895 14:42:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389986816; Write bytes: 382596608; Read time: 30194; Write time: 702 14:42:00 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 33406464; Write bytes: 300647936; Read time: 353; Write time: 1143 14:42:00 INFO - Running post-run listener: _upload_blobber_files 14:42:00 INFO - Blob upload gear active. 14:42:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:42:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:42:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:42:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:42:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:02 INFO - (blobuploader) - INFO - Done attempting. 14:42:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:42:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:42:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:42:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:04 INFO - (blobuploader) - INFO - Done attempting. 14:42:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:04 INFO - Return code: 0 14:42:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f059dcfd3bed8ad664aa1dda78e992554e018e642a4eeb70273503b93c5b55705a24afb4f98c2386a111aeafa58120dd5ef7e259580d591aabb19eeb5e5ba368", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9aa027e1d195edf1f143d63130e78f8ad5a464c71079d783e7023b5e016ccff812ca4878c2bd85fdb9913e3ab72bf552cfc5343ea170fc4458d28f4820fe202f"} 14:42:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:04 INFO - Contents: 14:42:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f059dcfd3bed8ad664aa1dda78e992554e018e642a4eeb70273503b93c5b55705a24afb4f98c2386a111aeafa58120dd5ef7e259580d591aabb19eeb5e5ba368", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9aa027e1d195edf1f143d63130e78f8ad5a464c71079d783e7023b5e016ccff812ca4878c2bd85fdb9913e3ab72bf552cfc5343ea170fc4458d28f4820fe202f"} 14:42:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:04 INFO - Copying logs to upload dir... 14:42:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.741407 ========= master_lag: 1.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-25 14:42:05.319415) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-03-25 14:42:05.323854) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/f059dcfd3bed8ad664aa1dda78e992554e018e642a4eeb70273503b93c5b55705a24afb4f98c2386a111aeafa58120dd5ef7e259580d591aabb19eeb5e5ba368", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9aa027e1d195edf1f143d63130e78f8ad5a464c71079d783e7023b5e016ccff812ca4878c2bd85fdb9913e3ab72bf552cfc5343ea170fc4458d28f4820fe202f"} build_url:https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011490 build_url: 'https://queue.taskcluster.net/v1/task/f1m652wqSv6-HzVK4N9NqQ/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/f059dcfd3bed8ad664aa1dda78e992554e018e642a4eeb70273503b93c5b55705a24afb4f98c2386a111aeafa58120dd5ef7e259580d591aabb19eeb5e5ba368", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9aa027e1d195edf1f143d63130e78f8ad5a464c71079d783e7023b5e016ccff812ca4878c2bd85fdb9913e3ab72bf552cfc5343ea170fc4458d28f4820fe202f"}' ========= master_lag: 8.80 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 8 secs) (at 2016-03-25 14:42:14.140252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-25 14:42:14.144602) ========= 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.IgP2QxRKEw/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.modjbbIFES/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005196 ========= master_lag: 6.82 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-25 14:42:20.974170) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-25 14:42:20.974479) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-03-25 14:42:22.420781) ========= ========= Total master_lag: 49.17 =========