builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0153 starttime: 1456372173.31 results: success (0) buildid: 20160224180530 builduid: fc31164e58b045278866f7b16b4c6e9d revision: 8d2eef5f724985debb334f0d69465215bb200fe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.307916) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.308454) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.308769) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005923 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.333370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.334016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.349754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.350102) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005318 ========= master_lag: 0.22 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.570929) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.571241) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.571625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.571897) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-02-24 19:49:33-- 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% 7.31M=0.002s 2016-02-24 19:49:33 (7.31 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169677 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.758866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.759208) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.020164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:33.807916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 19:49:33.808354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8d2eef5f724985debb334f0d69465215bb200fe0 --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 8d2eef5f724985debb334f0d69465215bb200fe0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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-02-24 19:49:33,889 truncating revision to first 12 chars 2016-02-24 19:49:33,889 Setting DEBUG logging. 2016-02-24 19:49:33,889 attempt 1/10 2016-02-24 19:49:33,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8d2eef5f7249?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 19:49:35,580 unpacking tar archive at: fx-team-8d2eef5f7249/testing/mozharness/ program finished with exit code 0 elapsedTime=1.931737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 19:49:35.756784) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:35.760144) ========= echo 8d2eef5f724985debb334f0d69465215bb200fe0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8d2eef5f724985debb334f0d69465215bb200fe0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 8d2eef5f724985debb334f0d69465215bb200fe0 program finished with exit code 0 elapsedTime=0.004981 script_repo_revision: '8d2eef5f724985debb334f0d69465215bb200fe0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:35.810805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:35.811511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 19:49:35.826068) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-24 19:49:35.826344) ========= /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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:49:36 INFO - MultiFileLogger online at 20160224 19:49:36 in /builds/slave/test 19:49:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:49:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:36 INFO - {'append_to_log': False, 19:49:36 INFO - 'base_work_dir': '/builds/slave/test', 19:49:36 INFO - 'blob_upload_branch': 'Fx-Team', 19:49:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:36 INFO - 'branch': 'Fx-Team', 19:49:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:36 INFO - 'config_files': ('talos/mac_config.py',), 19:49:36 INFO - 'default_actions': ('clobber', 19:49:36 INFO - 'read-buildbot-config', 19:49:36 INFO - 'download-and-extract', 19:49:36 INFO - 'populate-webroot', 19:49:36 INFO - 'create-virtualenv', 19:49:36 INFO - 'install', 19:49:36 INFO - 'run-tests'), 19:49:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:36 INFO - 'download_minidump_stackwalk': True, 19:49:36 INFO - 'download_symbols': 'ondemand', 19:49:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:36 INFO - 'installer_path': 'installer.exe', 19:49:36 INFO - 'log_level': 'info', 19:49:36 INFO - 'log_name': 'talos', 19:49:36 INFO - 'log_to_console': True, 19:49:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:49:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:49:36 INFO - 'opt_config_files': (), 19:49:36 INFO - 'pip_index': False, 19:49:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:36 INFO - 'cmd': ('bash', 19:49:36 INFO - '-c', 19:49:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:36 INFO - 'enabled': True, 19:49:36 INFO - 'halt_on_failure': False, 19:49:36 INFO - 'name': 'check_screen_resolution'},), 19:49:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:36 INFO - 'cmd': ('bash', 19:49:36 INFO - '-c', 19:49:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:36 INFO - 'enabled': True, 19:49:36 INFO - 'halt_on_failure': False, 19:49:36 INFO - 'name': 'check_screen_resolution'},), 19:49:36 INFO - 'run_cmd_checks_enabled': True, 19:49:36 INFO - 'sps_profile': False, 19:49:36 INFO - 'sps_profile_interval': 0, 19:49:36 INFO - 'suite': 'dromaeojs', 19:49:36 INFO - 'system_bits': '32', 19:49:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:36 INFO - 'title': 't-yosemite-r7-0153', 19:49:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:36 INFO - 'use_talos_json': True, 19:49:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:36 INFO - 'work_dir': 'build'} 19:49:36 INFO - ##### 19:49:36 INFO - ##### Running clobber step. 19:49:36 INFO - ##### 19:49:36 INFO - Running pre-action listener: _resource_record_pre_action 19:49:36 INFO - Running main action method: clobber 19:49:36 INFO - rmtree: /builds/slave/test/build 19:49:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:37 INFO - Running post-action listener: _resource_record_post_action 19:49:37 INFO - ##### 19:49:37 INFO - ##### Running read-buildbot-config step. 19:49:37 INFO - ##### 19:49:37 INFO - Running pre-action listener: _resource_record_pre_action 19:49:37 INFO - Running main action method: read_buildbot_config 19:49:37 INFO - Using buildbot properties: 19:49:37 INFO - { 19:49:37 INFO - "project": "", 19:49:37 INFO - "product": "firefox", 19:49:37 INFO - "script_repo_revision": "production", 19:49:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:49:37 INFO - "repository": "", 19:49:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:49:37 INFO - "buildid": "20160224180530", 19:49:37 INFO - "pgo_build": "False", 19:49:37 INFO - "basedir": "/builds/slave/test", 19:49:37 INFO - "buildnumber": 496, 19:49:37 INFO - "slavename": "t-yosemite-r7-0153", 19:49:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:49:37 INFO - "platform": "yosemite_r7", 19:49:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:49:37 INFO - "branch": "fx-team", 19:49:37 INFO - "repo_path": "integration/fx-team", 19:49:37 INFO - "revision": "8d2eef5f724985debb334f0d69465215bb200fe0", 19:49:37 INFO - "stage_platform": "macosx64", 19:49:37 INFO - "builduid": "fc31164e58b045278866f7b16b4c6e9d", 19:49:37 INFO - "slavebuilddir": "test" 19:49:37 INFO - } 19:49:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:49:37 INFO - Running post-action listener: _resource_record_post_action 19:49:37 INFO - ##### 19:49:37 INFO - ##### Running download-and-extract step. 19:49:37 INFO - ##### 19:49:37 INFO - Running pre-action listener: _resource_record_pre_action 19:49:37 INFO - Running main action method: download_and_extract 19:49:37 INFO - mkdir: /builds/slave/test/build/tests 19:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:37 INFO - https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:49:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/test_packages.json 19:49:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/test_packages.json 19:49:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:49:39 INFO - Downloaded 1277 bytes. 19:49:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:49:39 INFO - Using the following test package requirements: 19:49:39 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:49:39 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:49:39 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:49:39 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'jsshell-mac.zip'], 19:49:39 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:49:39 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:49:39 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:49:39 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:49:39 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:49:39 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:49:39 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:49:39 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:49:39 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:39 INFO - https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:49:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:40 INFO - Downloaded 17828797 bytes. 19:49:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:49:43 INFO - Return code: 0 19:49:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:49: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')]} 19:49:43 INFO - https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:49:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:44 INFO - Downloaded 17828797 bytes. 19:49:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:49:48 INFO - Return code: 0 19:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:48 INFO - https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:49:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:49:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:49:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:49:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:49:49 INFO - Downloaded 10707015 bytes. 19:49:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:49:49 INFO - Return code: 0 19:49:49 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')]} 19:49:49 INFO - https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:49:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:49:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:49:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 19:49:54 INFO - Downloaded 111440447 bytes. 19:49:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:49:54 INFO - mkdir: /builds/slave/test/properties 19:49:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:49:54 INFO - Writing to file /builds/slave/test/properties/build_url 19:49:54 INFO - Contents: 19:49:54 INFO - build_url:https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:49:55 INFO - Running post-action listener: _resource_record_post_action 19:49:55 INFO - Running post-action listener: set_extra_try_arguments 19:49:55 INFO - ##### 19:49:55 INFO - ##### Running populate-webroot step. 19:49:55 INFO - ##### 19:49:55 INFO - Running pre-action listener: _resource_record_pre_action 19:49:55 INFO - Running main action method: populate_webroot 19:49:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:55 INFO - '--tppagecycles', 19:49:55 INFO - '7'], 19:49:55 INFO - 'tests': ['tsvgm']}}, 19:49:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:49:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:49:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:49:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'tests': ['damp', 'tps']}, 19:49:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['damp', 'tps']}, 19:49:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:49:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:55 INFO - 'other': {'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'other_l64': {'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'other_nol64': {'tests': ['a11yr', 19:49:55 INFO - 'ts_paint', 19:49:55 INFO - 'tpaint', 19:49:55 INFO - 'sessionrestore', 19:49:55 INFO - 'sessionrestore_no_auto_restore']}, 19:49:55 INFO - 'svgr': {'tests': ['tsvgx', 19:49:55 INFO - 'tsvgr_opacity', 19:49:55 INFO - 'tart', 19:49:55 INFO - 'tscrollx', 19:49:55 INFO - 'cart']}, 19:49:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['tsvgx', 19:49:55 INFO - 'tsvgr_opacity', 19:49:55 INFO - 'tart', 19:49:55 INFO - 'tscrollx', 19:49:55 INFO - 'cart']}, 19:49:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'tests': ['tp5o']}, 19:49:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'talos_options': ['--e10s'], 19:49:55 INFO - 'tests': ['tp5o']}, 19:49:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'talos_options': ['--xperf_path', 19:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:55 INFO - 'tests': ['tp5n']}, 19:49:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:55 INFO - 'talos_options': ['--e10s', 19:49:55 INFO - '--xperf_path', 19:49:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:55 INFO - 'tests': ['tp5n']}}, 19:49:55 INFO - 'talos.zip': {'path': '', 19:49:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:55 INFO - Running post-action listener: _resource_record_post_action 19:49:55 INFO - ##### 19:49:55 INFO - ##### Running create-virtualenv step. 19:49:55 INFO - ##### 19:49:55 INFO - Running pre-action listener: _resource_record_pre_action 19:49:55 INFO - Running main action method: create_virtualenv 19:49:55 INFO - Creating virtualenv /builds/slave/test/build/venv 19:49:55 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 19:49:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:49:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:55 INFO - Using real prefix '/tools/python27' 19:49:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:49:56 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:59 INFO - Installing pip.................done. 19:49:59 INFO - Return code: 0 19:49:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:49:59 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')]} 19:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 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')]} 19:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:49:59 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 19:49:59 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 19:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:59 INFO - 'HOME': '/Users/cltbld', 19:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:59 INFO - 'LOGNAME': 'cltbld', 19:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:59 INFO - 'MOZ_NO_REMOTE': '1', 19:49:59 INFO - 'NO_EM_RESTART': '1', 19:49:59 INFO - 'PAGER': '/bin/cat', 19:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:59 INFO - 'PWD': '/builds/slave/test', 19:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:59 INFO - 'SHELL': '/bin/bash', 19:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:49:59 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:59 INFO - 'USER': 'cltbld', 19:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:59 INFO - 'XPC_FLAGS': '0x0', 19:49:59 INFO - 'XPC_SERVICE_NAME': '0', 19:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:59 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 19:49:59 INFO - Cleaning up... 19:49:59 INFO - Return code: 0 19:49:59 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:49:59 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')]} 19:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 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')]} 19:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:59 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:49:59 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 19:49:59 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 19:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:59 INFO - 'HOME': '/Users/cltbld', 19:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:59 INFO - 'LOGNAME': 'cltbld', 19:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:59 INFO - 'MOZ_NO_REMOTE': '1', 19:49:59 INFO - 'NO_EM_RESTART': '1', 19:49:59 INFO - 'PAGER': '/bin/cat', 19:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:59 INFO - 'PWD': '/builds/slave/test', 19:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:59 INFO - 'SHELL': '/bin/bash', 19:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:49:59 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:59 INFO - 'USER': 'cltbld', 19:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:59 INFO - 'XPC_FLAGS': '0x0', 19:49:59 INFO - 'XPC_SERVICE_NAME': '0', 19:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:59 INFO - Downloading/unpacking psutil>=0.7.1 19:49:59 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 19:49:59 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 19:49:59 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 19:49:59 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 19:49:59 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 19:49:59 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 19:50:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:50:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:02 INFO - Installing collected packages: psutil 19:50:02 INFO - Running setup.py install for psutil 19:50:02 INFO - building 'psutil._psutil_osx' extension 19:50:02 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 19:50:02 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 19:50:02 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 19:50:03 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 19:50:03 INFO - building 'psutil._psutil_posix' extension 19:50:03 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 19:50:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:50:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:50:03 INFO - ^ 19:50:03 INFO - 1 warning generated. 19:50:03 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 19:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:50:03 INFO - Successfully installed psutil 19:50:03 INFO - Cleaning up... 19:50:03 INFO - Return code: 0 19:50:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:50:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:03 INFO - 'HOME': '/Users/cltbld', 19:50:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:03 INFO - 'LOGNAME': 'cltbld', 19:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:03 INFO - 'MOZ_NO_REMOTE': '1', 19:50:03 INFO - 'NO_EM_RESTART': '1', 19:50:03 INFO - 'PAGER': '/bin/cat', 19:50:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:03 INFO - 'PWD': '/builds/slave/test', 19:50:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:03 INFO - 'SHELL': '/bin/bash', 19:50:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:03 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:03 INFO - 'USER': 'cltbld', 19:50:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:03 INFO - 'XPC_FLAGS': '0x0', 19:50:03 INFO - 'XPC_SERVICE_NAME': '0', 19:50:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:50:06 INFO - Installing collected packages: mozsystemmonitor 19:50:06 INFO - Running setup.py install for mozsystemmonitor 19:50:06 INFO - Successfully installed mozsystemmonitor 19:50:06 INFO - Cleaning up... 19:50:06 INFO - Return code: 0 19:50:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:50:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:06 INFO - 'HOME': '/Users/cltbld', 19:50:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:06 INFO - 'LOGNAME': 'cltbld', 19:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:06 INFO - 'MOZ_NO_REMOTE': '1', 19:50:06 INFO - 'NO_EM_RESTART': '1', 19:50:06 INFO - 'PAGER': '/bin/cat', 19:50:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:06 INFO - 'PWD': '/builds/slave/test', 19:50:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:06 INFO - 'SHELL': '/bin/bash', 19:50:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:06 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:06 INFO - 'USER': 'cltbld', 19:50:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:06 INFO - 'XPC_FLAGS': '0x0', 19:50:06 INFO - 'XPC_SERVICE_NAME': '0', 19:50:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:06 INFO - Downloading/unpacking blobuploader==1.2.4 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:50:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:50:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:10 INFO - Downloading docopt-0.6.1.tar.gz 19:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:50:10 INFO - Installing collected packages: blobuploader, requests, docopt 19:50:10 INFO - Running setup.py install for blobuploader 19:50:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:50:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:50:10 INFO - Running setup.py install for requests 19:50:10 INFO - Running setup.py install for docopt 19:50:10 INFO - Successfully installed blobuploader requests docopt 19:50:10 INFO - Cleaning up... 19:50:11 INFO - Return code: 0 19:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:11 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')]} 19:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 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')]} 19:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:11 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:11 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 19:50:11 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 19:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:11 INFO - 'HOME': '/Users/cltbld', 19:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:11 INFO - 'LOGNAME': 'cltbld', 19:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:11 INFO - 'MOZ_NO_REMOTE': '1', 19:50:11 INFO - 'NO_EM_RESTART': '1', 19:50:11 INFO - 'PAGER': '/bin/cat', 19:50:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:11 INFO - 'PWD': '/builds/slave/test', 19:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:11 INFO - 'SHELL': '/bin/bash', 19:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:11 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:11 INFO - 'USER': 'cltbld', 19:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:11 INFO - 'XPC_FLAGS': '0x0', 19:50:11 INFO - 'XPC_SERVICE_NAME': '0', 19:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ongOxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-iPF2ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ItrkUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-jds5mJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ULGFyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-B9920G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:11 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-rJVQIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-qbkwgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-fTsDi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-bHwYB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-c7bs4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Bu9lWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-OVY4Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-0v3e1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XEpvtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-6rDnC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:12 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-wCwoE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:50:13 INFO - Running setup.py install for manifestparser 19:50:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:50:13 INFO - Running setup.py install for mozcrash 19:50:13 INFO - Running setup.py install for mozdebug 19:50:13 INFO - Running setup.py install for mozdevice 19:50:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:50:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:50:13 INFO - Running setup.py install for mozfile 19:50:13 INFO - Running setup.py install for mozhttpd 19:50:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:50:13 INFO - Running setup.py install for mozinfo 19:50:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Running setup.py install for mozInstall 19:50:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Running setup.py install for mozleak 19:50:14 INFO - Running setup.py install for mozlog 19:50:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Running setup.py install for moznetwork 19:50:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Running setup.py install for mozprocess 19:50:14 INFO - Running setup.py install for mozprofile 19:50:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:50:14 INFO - Running setup.py install for mozrunner 19:50:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:50:15 INFO - Running setup.py install for mozscreenshot 19:50:15 INFO - Running setup.py install for moztest 19:50:15 INFO - Running setup.py install for mozversion 19:50:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:50:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:50:15 INFO - Cleaning up... 19:50:15 INFO - Return code: 0 19:50:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:15 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')]} 19:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:15 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')]} 19:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:15 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:15 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 19:50:15 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 19:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:15 INFO - 'HOME': '/Users/cltbld', 19:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:15 INFO - 'LOGNAME': 'cltbld', 19:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:15 INFO - 'MOZ_NO_REMOTE': '1', 19:50:15 INFO - 'NO_EM_RESTART': '1', 19:50:15 INFO - 'PAGER': '/bin/cat', 19:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:15 INFO - 'PWD': '/builds/slave/test', 19:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:15 INFO - 'SHELL': '/bin/bash', 19:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:15 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:15 INFO - 'USER': 'cltbld', 19:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:15 INFO - 'XPC_FLAGS': '0x0', 19:50:15 INFO - 'XPC_SERVICE_NAME': '0', 19:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:50:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-ObzXTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:50:15 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)) 19:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:50:15 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-FrxBNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-toeetj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-778VsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XJbgP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-UlUPvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XkLFQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-p5ItKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-XtYENE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-PD2JrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:50:16 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)) 19:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:50:16 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-7qJU5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-gpSCeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-Oavx5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-dwR2wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-SsdDSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-bYJCdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:50:17 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)) 19:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:50:17 INFO - Running setup.py (path:/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/pip-duGW1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:50:17 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)) 19:50:17 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:50:17 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:50:17 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)) 19:50:17 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)) 19:50:17 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)) 19:50:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:50:17 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 19:50:17 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 19:50:17 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 19:50:17 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 19:50:17 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 19:50:17 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 19:50:19 INFO - Downloading blessings-1.6.tar.gz 19:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:50:20 INFO - Installing collected packages: blessings 19:50:20 INFO - Running setup.py install for blessings 19:50:20 INFO - Successfully installed blessings 19:50:20 INFO - Cleaning up... 19:50:20 INFO - Return code: 0 19:50:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:50:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:50:20 INFO - Reading from file tmpfile_stdout 19:50:20 INFO - Current package versions: 19:50:20 INFO - blessings == 1.6 19:50:20 INFO - blobuploader == 1.2.4 19:50:20 INFO - docopt == 0.6.1 19:50:20 INFO - manifestparser == 1.1 19:50:20 INFO - mozInstall == 1.12 19:50:20 INFO - mozcrash == 0.16 19:50:20 INFO - mozdebug == 0.1 19:50:20 INFO - mozdevice == 0.48 19:50:20 INFO - mozfile == 1.2 19:50:20 INFO - mozhttpd == 0.7 19:50:20 INFO - mozinfo == 0.9 19:50:20 INFO - mozleak == 0.1 19:50:20 INFO - mozlog == 3.1 19:50:20 INFO - moznetwork == 0.27 19:50:20 INFO - mozprocess == 0.22 19:50:20 INFO - mozprofile == 0.28 19:50:20 INFO - mozrunner == 6.11 19:50:20 INFO - mozscreenshot == 0.1 19:50:20 INFO - mozsystemmonitor == 0.0 19:50:20 INFO - moztest == 0.7 19:50:20 INFO - mozversion == 1.4 19:50:20 INFO - psutil == 3.1.1 19:50:20 INFO - requests == 1.2.3 19:50:20 INFO - wsgiref == 0.1.2 19:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:20 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:20 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 19:50:20 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 19:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:20 INFO - 'HOME': '/Users/cltbld', 19:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:20 INFO - 'LOGNAME': 'cltbld', 19:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:20 INFO - 'MOZ_NO_REMOTE': '1', 19:50:20 INFO - 'NO_EM_RESTART': '1', 19:50:20 INFO - 'PAGER': '/bin/cat', 19:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:20 INFO - 'PWD': '/builds/slave/test', 19:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:20 INFO - 'SHELL': '/bin/bash', 19:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:20 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:20 INFO - 'USER': 'cltbld', 19:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:20 INFO - 'XPC_FLAGS': '0x0', 19:50:20 INFO - 'XPC_SERVICE_NAME': '0', 19:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 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)) 19:50:20 INFO - Cleaning up... 19:50:20 INFO - Return code: 0 19:50:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:20 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:20 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 19:50:20 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 19:50:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:20 INFO - 'HOME': '/Users/cltbld', 19:50:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:20 INFO - 'LOGNAME': 'cltbld', 19:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:20 INFO - 'MOZ_NO_REMOTE': '1', 19:50:20 INFO - 'NO_EM_RESTART': '1', 19:50:20 INFO - 'PAGER': '/bin/cat', 19:50:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:20 INFO - 'PWD': '/builds/slave/test', 19:50:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:20 INFO - 'SHELL': '/bin/bash', 19:50:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:20 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:20 INFO - 'USER': 'cltbld', 19:50:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:20 INFO - 'XPC_FLAGS': '0x0', 19:50:20 INFO - 'XPC_SERVICE_NAME': '0', 19:50:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:21 INFO - Downloading/unpacking jsonschema 19:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:50:23 INFO - Downloading/unpacking functools32 (from jsonschema) 19:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:23 INFO - Downloading functools32-3.2.3-2.tar.gz 19:50:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:50:23 INFO - warning: no files found matching '*.txt' 19:50:23 INFO - no previously-included directories found matching 'build' 19:50:23 INFO - no previously-included directories found matching 'dist' 19:50:23 INFO - no previously-included directories found matching '.git*' 19:50:23 INFO - Installing collected packages: jsonschema, functools32 19:50:23 INFO - Running setup.py install for functools32 19:50:24 INFO - warning: no files found matching '*.txt' 19:50:24 INFO - no previously-included directories found matching 'build' 19:50:24 INFO - no previously-included directories found matching 'dist' 19:50:24 INFO - no previously-included directories found matching '.git*' 19:50:24 INFO - Successfully installed jsonschema functools32 19:50:24 INFO - Cleaning up... 19:50:24 INFO - Return code: 0 19:50:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:50:24 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')]} 19:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:24 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')]} 19:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:50:24 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 0x10d6dda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d6e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1c9579630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, '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.atmERWiPUZ/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.82RtjsYIdr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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 19:50:24 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 19:50:24 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 19:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:24 INFO - 'HOME': '/Users/cltbld', 19:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:24 INFO - 'LOGNAME': 'cltbld', 19:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:24 INFO - 'MOZ_NO_REMOTE': '1', 19:50:24 INFO - 'NO_EM_RESTART': '1', 19:50:24 INFO - 'PAGER': '/bin/cat', 19:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:24 INFO - 'PWD': '/builds/slave/test', 19:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:24 INFO - 'SHELL': '/bin/bash', 19:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:50:24 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:24 INFO - 'USER': 'cltbld', 19:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:24 INFO - 'XPC_FLAGS': '0x0', 19:50:24 INFO - 'XPC_SERVICE_NAME': '0', 19:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:50:24 INFO - Downloading/unpacking flake8 19:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:50:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:50:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:50:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50: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 19:50:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:50:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 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 19:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:27 INFO - no previously-included directories found matching 'docs/_build' 19:50:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:50:28 INFO - Running setup.py install for pep8 19:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:50:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:50:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:50:28 INFO - no previously-included directories found matching 'docs/_build' 19:50:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:50:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:50:28 INFO - Cleaning up... 19:50:28 INFO - Return code: 0 19:50:28 INFO - Running post-action listener: _resource_record_post_action 19:50:28 INFO - Running post-action listener: _start_resource_monitoring 19:50:28 INFO - Starting resource monitoring. 19:50:28 INFO - ##### 19:50:28 INFO - ##### Running install step. 19:50:28 INFO - ##### 19:50:28 INFO - Running pre-action listener: _resource_record_pre_action 19:50:28 INFO - Running main action method: install 19:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:50:28 INFO - Reading from file tmpfile_stdout 19:50:28 INFO - Detecting whether we're running mozinstall >=1.0... 19:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:50:28 INFO - Reading from file tmpfile_stdout 19:50:28 INFO - Output received: 19:50:28 INFO - Usage: mozinstall [options] installer 19:50:28 INFO - Options: 19:50:28 INFO - -h, --help show this help message and exit 19:50:28 INFO - -d DEST, --destination=DEST 19:50:28 INFO - Directory to install application into. [default: 19:50:28 INFO - "/builds/slave/test"] 19:50:28 INFO - --app=APP Application being installed. [default: firefox] 19:50:28 INFO - mkdir: /builds/slave/test/build/application 19:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:51:02 INFO - Reading from file tmpfile_stdout 19:51:02 INFO - Output received: 19:51:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:51:02 INFO - Running post-action listener: _resource_record_post_action 19:51:02 INFO - ##### 19:51:02 INFO - ##### Running run-tests step. 19:51:02 INFO - ##### 19:51:02 INFO - Running pre-action listener: _resource_record_pre_action 19:51:02 INFO - Running main action method: run_tests 19:51:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:51:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:51:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:51:02 INFO - 2016-02-24 19:51:02.374 screenresolution[1944:10433] starting screenresolution argv=screenresolution get 19:51:02 INFO - 2016-02-24 19:51:02.376 screenresolution[1944:10433] Display 0: 1600x1200x32@60 19:51:02 INFO - 2016-02-24 19:51:02.382 screenresolution[1945:10435] starting screenresolution argv=screenresolution list 19:51:02 INFO - Available Modes on Display 0 19:51:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:51:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:51:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:51:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:51:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:51:02 INFO - Intel Iris: 19:51:02 INFO - Chipset Model: Intel Iris 19:51:02 INFO - Type: GPU 19:51:02 INFO - Bus: Built-In 19:51:02 INFO - VRAM (Dynamic, Max): 1536 MB 19:51:02 INFO - Vendor: Intel (0x8086) 19:51:02 INFO - Device ID: 0x0a2e 19:51:02 INFO - Revision ID: 0x0009 19:51:02 INFO - Displays: 19:51:02 INFO - Display: 19:51:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:51:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:51:02 INFO - Display Serial Number: 1600x1200 60 19:51:02 INFO - Main Display: Yes 19:51:02 INFO - Mirror: Off 19:51:02 INFO - Online: Yes 19:51:02 INFO - Rotation: Supported 19:51:02 INFO - Return code: 0 19:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:51:02 INFO - Python 2.7.3 19:51:02 INFO - Return code: 0 19:51:02 INFO - grabbing minidump binary from tooltool 19:51: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')]} 19:51:02 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 0x10d581d30>, '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 0x10d3a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d578b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:51:02 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 19:51:02 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 19:51:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:51:02 INFO - Return code: 0 19:51:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:51:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:51:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:51:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:51:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:51:03 INFO - Return code: 0 19:51:03 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/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 19:51:03 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/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0153 --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 19:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.atmERWiPUZ/Render', 19:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:03 INFO - 'HOME': '/Users/cltbld', 19:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:03 INFO - 'LOGNAME': 'cltbld', 19:51:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:51:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:03 INFO - 'MOZ_NO_REMOTE': '1', 19:51:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:51:03 INFO - 'NO_EM_RESTART': '1', 19:51:03 INFO - 'PAGER': '/bin/cat', 19:51:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:03 INFO - 'PWD': '/builds/slave/test', 19:51:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:03 INFO - 'SHELL': '/bin/bash', 19:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.82RtjsYIdr/Listeners', 19:51:03 INFO - 'TMPDIR': '/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/', 19:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:03 INFO - 'USER': 'cltbld', 19:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:03 INFO - 'XPC_FLAGS': '0x0', 19:51:03 INFO - 'XPC_SERVICE_NAME': '0', 19:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:03 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/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0153', '--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 19:51:04 INFO - mozversion application_buildid: 20160224180530 19:51:04 INFO - mozversion application_changeset: 8d2eef5f724985debb334f0d69465215bb200fe0 19:51:04 INFO - mozversion application_display_name: Nightly 19:51:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:51:04 INFO - mozversion application_name: Firefox 19:51:04 INFO - mozversion application_remotingname: firefox 19:51:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:51:04 INFO - mozversion application_vendor: Mozilla 19:51:04 INFO - mozversion application_version: 47.0a1 19:51:04 INFO - mozversion platform_buildid: 20160224180530 19:51:04 INFO - mozversion platform_changeset: 8d2eef5f724985debb334f0d69465215bb200fe0 19:51:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:51:04 INFO - mozversion platform_version: 47.0a1 19:51:04 INFO - using testdate: 1456372264 19:51:04 INFO - actual date: 1456372264 19:51:04 INFO - starting webserver on 'localhost:49709' 19:51:04 INFO - SUITE-START | Running 2 tests 19:51:04 INFO - TEST-START | dromaeo_css 19:51:04 INFO - operating with platform_type : mac_ 19:51:04 INFO - Initialising browser for dromaeo_css test... 19:51:04 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp5O52ZS/profile http://localhost:49709/getInfo.html) 19:51:06 INFO - PROCESS | 1963 | __metrics Screen width/height:1600/1200 19:51:06 INFO - PROCESS | 1963 | colorDepth:24 19:51:06 INFO - PROCESS | 1963 | Browser inner width/height: 1024/689 19:51:06 INFO - PROCESS | 1963 | __metrics 19:51:06 INFO - PROCESS | 1963 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:51:06 INFO - PROCESS | 1963 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:51:07 INFO - TEST-INFO | 1963: exit 0 19:51:07 INFO - Browser initialized. 19:51:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:51:07 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmp5O52ZS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:51:19 INFO - PROCESS | 1966 | RSS: Main: 244699136 19:51:19 INFO - PROCESS | 1966 | 19:52:10 INFO - PROCESS | 1966 | 1456372330647 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] 19:54:20 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49709/tests/dromaeo/cssquery-ext.html) 19:54:22 INFO - PROCESS | 1966 | RSS: Main: 331624448 19:54:22 INFO - PROCESS | 1966 | 19:57:24 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-ext.html (next: http://localhost:49709/tests/dromaeo/cssquery-jquery.html) 19:57:25 INFO - PROCESS | 1966 | RSS: Main: 380805120 19:57:25 INFO - PROCESS | 1966 | 20:00:27 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49709/tests/dromaeo/cssquery-mootools.html) 20:00:28 INFO - PROCESS | 1966 | RSS: Main: 377991168 20:00:28 INFO - PROCESS | 1966 | 20:03:30 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49709/tests/dromaeo/cssquery-prototype.html) 20:03:30 INFO - PROCESS | 1966 | RSS: Main: 339439616 20:03:30 INFO - PROCESS | 1966 | 20:06:33 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49709/tests/dromaeo/cssquery-yui.html) 20:06:34 INFO - PROCESS | 1966 | RSS: Main: 343281664 20:06:34 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | Cycle 1(1): loaded http://localhost:49709/tests/dromaeo/cssquery-yui.html (next: http://localhost:49709/tests/dromaeo/cssquery-dojo.html) 20:09:37 INFO - PROCESS | 1966 | RSS: Main: 405868544 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | __start_tp_report 20:09:37 INFO - PROCESS | 1966 | _x_x_mozilla_page_load 20:09:37 INFO - PROCESS | 1966 | _x_x_mozilla_page_load_details 20:09:37 INFO - PROCESS | 1966 | |i|pagename|runs| 20:09:37 INFO - PROCESS | 1966 | |0;dojo.html;3151;3460.4463285874267;3463.982680086599;3499.3701133795907;3500.3874321993644;5594.24477695511;5661.4055524169935;5666.914996275054;5693.174489698991;5704.686242256679;4919.434265059519;5575.609707320489;5678.318601767794;5679.8580035499135;5682.261306030221;5114.744262786864;5145.0481660892665;5155.175171972485;5176.948230517703;5240.79036838526;5239.947600524003;5247.527722504974;5250.422453530108;5251.658642188246;5261.736913154346;5148.536631703146;5175.87060323493;5188.455212202721;5216.895662086756;5218.686878787266;5215.322008138955;5263.947360526384;5270.209468579706;5277.023750606112;5334.786608535654;4989.65072444929;5033.219850923113;5112.923306150411;5184.274201611777;5198.324217851693;5560.944390556083;5569.053260945609;5585.832425027215;5633.324001119892;5695;6242.812715618538;6245.6252624842655;6247.531435142382;6251.3123556408755;6272.65500397478;6123.130109042722;6215.223097112861;6276.089966954812;6284.434400903895;6284.905726414107;5780.479756821865;5813.82558523245;5817.94182058174;5837.124431335291;5887.411258874121;6273.780417685451;6305.621662700252;6372.36276372359;6374.203224596926;6385.648789316632;5949.315828679671;6064.848378790477;6179.351168127372;6248.250209974832;6258.74965001404;6235.688215589203;6277.466415354746;6287.717052732546;6297.685115744194;6303.590266632654;6241.812745617639;6251.9687401563615;6254.499640028786;6256.311805701369;6273.560850740404;5171.663841850268;6121.326654068049;6146.924288249538;6187.535934804818;6268.717907694165;4900.093482705711;4903.289023091632;4904.5340692634145;4906.484819093944;4925.975370123127;3779.3764028934916;4365.236083685342;4384.56154384559;4403.515613282536;4414.779261037;5608.943910560843;5709.371969083398;5743.913841292384;5805.448482394166;5849.795257165979;6230.875382492325;6260.186175797208;6268.028455589391;6294.464970477469;6299.653519056405;5642.04085305499;5738;5772.740226689809;5773.191753154561;5773.8556536086935;5353.2237825515085;5393.164059570773;5393.649412788234;5402.8109016185035;5442.23808666779;6347.206599175103;6366.458850997532;6374.840628984312;6389.361063893573;6404.615723056631;6158.199434073721;6236.220472440945;6279.277883043325;6301.6534090625455;6318.368163183645;6327.936720632735;6335.968320158554;6336.366363363811;6351.872962540631;6363.872722545616;6144.262688477412;6187.1647327612;6210.130581718473;6233.937660623335;6242.094896240111;6141.9385806143155;6191;6224.875502489835;6269.592476489013;6282.246130464374;6092.055731361646;6107.816765497042;6121.387861213843;6123.7550497981365;6133.172021777182;5957.821265361873;6102.4507794298725;6102.877942441038;6109.236345456818;6144.969275153596;5818.330891947311;5981.581289309881;6025.397460254115;6101.45934676866;6105.664188469676;6044.425779550936;6072.78745243932;6112.8777424452155;6117.204763380732;6120.663363515049;4768;5226.712530810842;5837.09525023622;5910.940890591211;6041.284927575101 20:09:37 INFO - PROCESS | 1966 | |1;ext.html;427.4187105536472;540.8728948697055;546.7047794191137;601.0953514959986;619.5198720991232;29346.2663433414;39401;39957.40063899044;39977.20045599086;39999.400008999815;42741.145177096514;43297.56702432975;43327.56672433275;43356.56643433565;43388.6983390498;9522.80954380912;9736.805263894717;9755.707328780149;9763.707088787312;9773.169280611157;9599.760005999871;9763.609455621767;9765.755856103618;9769.706908792712;9779.315447918649;9680.27397945157;9754.219662426989;9760.658376956808;9796.167325777282;9798.853017204749;9667.70996870095;9738.220942324668;9755.36590121647;9759.414435133915;9760.95119524405;9539.046095390475;9678.27412944032;9705.61177552897;9711.708648740478;9732.464714440703;39916.80041599803;40194;40416;40450.595494044974;40475.39286910699;1851.2046809317892;3272.8527216275324;3279.6556361582166;3355.379254837863;3421.1447138215444;23133.958971846307;27504.862475687492;27595.310117247027;28409.43181136366;28975.84096636132;2833.4758069757163;2841.4459180459817;2861.899833505838;2888.0613800514707;2897.3915477749697;416947.91526042175;423712;425106;425116;426412.86793566146;59804.70097649484;60085.39914600886;60129;60172;60247.09629355476;58728;58762.41237587655;58835.41164588385;58858;59074.40925590689;16287.837121628869;16494.2577584009;16495.752563711554;16501.91749041247;16512.51387375142;12666.303353315656;12718.109732318833;12741.490340386466;12741.936290318488;12755.489780408865;17976.030698852504;18870.3395381161;19045.333413330467;19092.427227183205;19342.32301869428;6740.764073257511;7618.733344332922;8088.636011379502;8105.554194519358;8176.6320515576945;923.6351641101727;954.5322791831952;975.4147511493047;1012.3470361616716;1045.6078970386104;29520.409591808042;29603.25991850178;30814.69185308118;30822.69177308243;32788.180295492806;1075.9127293051456;1084.9891501084887;1093.278436232099;1128.5767837061103;1151.8157094864782;12180.147389682814;14411.42354305837;14593.78109328361;14669.706605867823;14785.482508112165;612257;662217;669253;669742;672171;49185.50814491881;54898.72550637221;55134.89730205454;55903.440965590635;55945.720271398386;1401.8668226518464;1419.3825685826698;1428;1431.2986636548226;1433.197409450711;27210.863945680147;28658;28871.42257154803;28962.27594310159;29742.10773676793;49891.750541247064;50009.499905000484;50357.49642503528;50405.74797126138;50447.24329134992;422452;425144;425169;425651;426176;30211.697883021767;30213.395732085675;31595.84202078975;31606.841965790023;31968.52047219247;41688.58311416968;41740;43080.35379469373;43216.78391608022;43242.56757432511;33958.15104622404;35098.82450587731;36052.27895442024;36092.45861312135;36182.63817361898;34656.133596659274;35521.644783551834;35629.28741425105;35910.92267231987;35991;28574.85712571507;35211.47182792209;35387.938361849185;36821;37290.81354593318;30240.395192095595;31215.68784312128;31278.06165815029;31368.37263254768;31402.21494462657;22825.657615135453;23312.46692824585;24496.75503245016;24758.50482990366;25775.355616109 20:09:37 INFO - PROCESS | 1966 | |2;jquery.html;360.4539123228309;362.5196614485807;362.52147165741235;370.0508196476039;370.6719553195421;15943.840561594381;16552.503424897273;19429.31997380092;19810.900945495272;20958.16167353306;19535.902320488414;19870.50323741907;19883.801161988376;20108.597828043432;20220.494487637818;5126.897462050775;5756.597038207327;6055.909161362583;6067.7572897084065;6106.450419462248;3954.9604503955024;4462.955370446286;4465.508794032654;4466.754328511931;5917.142014407908;4440.844570440036;6321.7471301148125;6614.570052946543;6615.768448104317;6624.5694029888145;6277.5291853110975;6539.574927629689;6554.70503827329;6560.179977502812;6591.242007169165;5669.489745922846;5681.545476361881;5683.062294721407;5686.147077938301;5689.687067211302;24197.87901060501;24440.38899027521;24768.5046299073;24798.628020579705;26098.478030439474;2063.66981282994;2117.4071260047212;2231.564844855254;2316.6177580699164;2869.0675530452686;14180.401975102597;14831.332590033366;14943.80905022377;14946.87898407613;15224.858135639872;1544.7528395456673;1653.4460955579896;1764.7176451767784;1765.161548264564;1860.2187081425834;90776.54611726965;91333.62999555012;102247.97752022534;106047.46976265147;106166.99999999923;10428.217883658755;10801.945990269998;11012.669619911416;11039.668809935714;11067.280626759395;13044.217346959213;13212.405441755143;13214.537491187955;13218.537351192854;13226;8369.49783013021;8521.147885211429;8538.87191692125;8600.913990860012;8608.182222688834;8670.523121228267;8690.478571285617;8695.08701586337;8737.694180703773;8757.693480728143;4402.295632698753;4476.612250202447;4489.214387482178;4503.752293623882;4520.706154099973;1482.2736858939043;1739.4694618141589;1793.6233390988039;1821.7813862336338;1840.162725959685;878.9780255493536;880.5333173418098;961.6634178037771;974.8683927669674;1000.2498126405196;15687.4509392173;18739.75379295953;20039.499012524804;20168.49578760543;20211.191552338038;858.4891989266376;879.5514287713312;943.7074506902882;978.6379039755336;1001.1990407673832;10464.843027354596;10793.46383046688;10814.31858910671;10980.670579882617;11031.767284556672;486767;507965;508765;552300;618087;99904.50047749715;115812.10469738324;118030.81969180198;119347;121706;920.5673333533229;1036.212478516318;1049.9842502362471;1111.2276967507505;1113.8886111388797;13424;18853.811461885205;18930.053497324803;19031.143598537823;19076.141573628942;33268;47632.7618361906;48260.27609585789;49057.018859621894;49533;68166;68638.31361686319;71665.92501112384;72534.63732681303;73484.89772653308;7851.9214807851195;8007.199280072179;8077.878831817645;8278.544680042656;8390;10505.68482945513;12653.810192846931;13482.52811151605;13545.661358466117;13663.316834158451;10613.9469302653;11356.716082098013;11638.5344586219;11641.243319184226;11668.88331116678;10680.8931910683;11127.72180695489;11226.326420414802;11476;11810.527578896748;7478.70085196586;8754.649814007369;9288.535573221447;9571.952140239533;11039.448027598428;7974.840503189787;8028;8038.196180381915;8040.959795200986;8215.465994710325;10701.892981070401;11432.314061156358;11716.121290903046;11748.29510229389;11792.70518237051 20:09:37 INFO - PROCESS | 1966 | |3;mootools.html;1203.7231436769537;1490.3665941974662;1529.1895295493393;1722.3282919661335;1905.4569447707406;7840.6863725450985;7951.966244388236;8577.914220857789;8603.268722158607;8606.139386061406;8344.91655083449;8642;8656.394052416334;8667.869981950276;8672.219500244977;2164.2316977473006;2216.767239439852;2217.84475086744;2364.385259832443;2472.11004038546;2386.677798497207;2444.1934161726676;2447.155731272717;2447.2413551799;2450.546648869956;2418.6734790803193;2423.09134074722;2463.6304554316816;2467.629855521677;2470.493548822487;2454.3373289211813;2465.1248806673552;2479.2686157583466;2493.551160791057;2495.700515938081;2439.1950656283384;2468.543319485901;2475.7648023437923;2499.7500249975037;2503.6369726389753;8818.823623527558;8870.911290887074;8892.73321800347;8893.866592001124;8902.198802107776;5417.674939503642;5496.615236933416;5505.862353441156;5549.1676248562635;5562.443755624446;3571.8749843755604;3627.310810945938;3696.057505336149;3700.85196592136;3706.944395834065;1046.9267151299412;1067.1889364083274;1067.6049861551276;1095.775366049958;1102.6581759654453;10048;11976.58081967127;12123.87876121245;12152.817707734392;12174.81737773934;4901.3383193268455;4929.3345398371475;4972.701637901738;4987.476314986947;5017.623678224075;10291.845622315672;10295.639652612123;10303;10313.690589282334;10314.02016808402;5498.560115190775;5507;5511.283533140666;5512.91730624041;5515.283013208337;4387.473503179639;4538.88652783683;4747.525247475225;4856.417229932431;4867.269909513601;3939.2712348215673;3957.1887763008513;3964.147708242742;3993.281209382339;4000.7799571023293;1299.6555912682957;1304.0871390027019;1306.9150505217322;1319.7756381415184;1320.306838909561;1053.6154303679255;1055.9049685528187;1079.2768844873954;1309.044397589765;1329.2954733991;8128.75613731589;8185.918140818635;8231.46495477792;8234.423590348619;8256.25693687571;443.45676546230607;504.2738456622452;513.5403813586819;516.367449873909;519.6959778529603;6184;6184.670295886406;6244.344343843922;6259.906101408392;6260.154879091265;10380.532876020598;10697.55582996301;10876.18428617841;10879.401632910265;10897.782044359068;9409.76475588102;10578.735531611617;10585.4707264638;10642.946785266024;10767.461626918623;8047;8173.591320433955;8215.58922053895;8278.917210827934;8287.212714792086;8143.5928203590765;8185.549794761345;8263.421560490708;8320.21115460179;8321.16788321163;9358.719238422858;9539.761505962406;9814.312998090065;9864.457454840052;9954.950225248827;9750.512474376395;10065.597376104874;10070.8489372658;10232.64185753495;10411;6168.784092556739;6840.931590684029;7087.255838136922;7515.248475152441;7676.347510461674;8185.590720463834;8213.753587392388;8249.381296402913;8255.215754503313;8257.133001034805;7215.639218039182;7346.52247603904;7353.632318384166;7477.588732619758;7478.775636730907;7241.493095483265;7262.709491620276;7305.707771689073;7378.372838308804;7406.222346653739;7741.922580774345;7746.961265193638;7783.182765809508;7789.883151752615;7795.376369890509;6749.122614060141;7009.684564194726;7068.469864760061;7075.292470752884;7075.787726368218;7059.011738356737;7133.714651413885;7135.286471352823;7139.785806425815;7141 20:09:37 INFO - PROCESS | 1966 | |4;prototype.html;284.221233819335;327.16083246472795;328.62044338788695;333.09896729347105;333.68966860819427;6429.324920883304;6586.736530538773;6602.273749887515;6635.445353538892;6646.966765166179;6478.643674597907;6522;6545.8363540911505;6546;6552.3775241352;4654.6974446661025;4789.449213340458;4790.568848803607;4908.705477671351;4929.827456039039;4860.368152140234;4865.859022030313;4881.096997055538;4907.2393778964315;4908.533689299511;4834.661573689843;4855.951440485585;4884.804607815683;4887.3890763654545;4888.242322440027;4634.189016922025;4635.072985402916;4738.147133515966;4757.119932812441;4760.904781904343;4068.5931406859077;4070.5115386153557;4079.8164082616354;4084.264832330179;4094.488188976378;6071.848203794896;6120.938790612126;6167.383261673796;6172.290186628506;6202.19371481709;5570.442955704438;5579.274694289757;5581.441855814427;5582.246396736429;5604.187392828017;6802.557833740791;6811.318868113199;6811.489138314597;6819.283975182584;6819.283975182584;3964.444977703124;4206.642435392995;4447.888802779924;4483.125790470859;4511.255642818931;7229.1686456057705;7322.560646361182;7334.559926404433;7336.706531738724;7343.7062517499235;4575.679702420865;4578.908421831545;4581.785826755912;4584.472785629629;4584.839530616479;4626.21354369758;4640.419947506562;4641.002184530342;4643;4649.04694537619;4452.621527170162;5507.917381239285;5510.8071217507195;5512.503874651301;5521.889562208814;6716.126903502513;6973.5118541701595;6988.371046605728;7008.789736307919;7019.017337572744;1594.7767312576248;1604.2620394618373;1615.2246921477756;1621.440602991966;1622.1889055472263;848.4951453884929;967.9612815487443;994.0606127209862;1023.1201166996377;1047.659510659039;6448.677566121675;6486.772962946368;6491.545591808528;6507.9023814642815;6544.509161812883;7116.181639111568;7133.607651579109;7135.001099846026;7135.143782746104;7148.678309476086;6421.21148522374;6423.935760642427;6436.839079022968;6440;6444.45222156122;3626.2928728897614;3735.701143908481;3768.491253680773;3780.640839120279;3780.8865734028022;7422.443316751157;7441.441891858024;7448.4041276697735;7474.654562178751;7475.8504829903095;7333.240022394587;7340.302671246223;7350.889736653848;7360.300771426706;7366.815829604196;7370.557766534025;7387.963060184557;7389.81525461857;7393.81515462107;7397.482176247611;6860.656967151723;7098.609576473137;7125.073740413713;7125.251848556034;7134.46491513149;6961.6171110587375;7019.508634395544;7019.719211231698;7020.7542736006035;7021.964890175516;6015.969920150371;7403;7411.1477180124975;7426.405887529093;7430.814229644086;4177.352510360899;4378.080603073263;4562.61217796491;4567.337736028324;4571.1543364477675;7050.682719277747;7065.788026359011;7067.222605513287;7069.575825450489;7071.71713131469;6761.797146085625;7072.7818842427605;7077.363037326665;7080.327368899946;7082.964585177041;7014.894776578458;7034.226235114235;7037.190723066708;7038.2961703829205;7044.260352662896;6867.141607299088;6870.31296870309;6875.759348422981;6880.798144593682;6888.104546408935;6768.627725475146;7030.50786444944;7032.331928466788;7041.401480874183;7051.964740176266;6605.2734199239;6717.697703603448;6725.092112564741;6852.280510546321;6855.691493882887 20:09:37 INFO - PROCESS | 1966 | |5;yui.html;695.7112798188751;741.436508253727;746.8543633991374;765.7702689193243;784.0982869699841;17510.474685759433;17709.822901770993;17817.554561135978;17826.643467130667;17835.554111147194;16000.83999160008;16069.357225710957;16101.0339379637;16103.275352609131;16240.269187886544;741.2217171969437;753.3370633842238;893.678275820704;915.4095608332622;915.9358844880861;895;897.833900728364;904.4030939579878;907.591583787295;908.2643059122099;943.6744323208482;949.6676163342844;950.7290422229665;952.1668540027476;952.2429668413594;775.8215610409637;936.9344145909789;938.7512309238023;942.5334459442552;949.4920217683575;698.9895151572731;702.3292755418563;704.0741425026074;705.2418649951322;706.8974998625222;15265.23673816316;15322.23388830554;15346.232688365648;15365.154916479589;15371.769423458658;12755.61733148007;12808.551700690432;12915;13188.274644894527;13244.86755132446;10022.198224142125;10132.226860299417;10245.641402550875;10265.127464165555;10281;2637.4593208392234;3596.7841929484052;3613.1509095362567;3646.3254297954963;3659.9268014639824;80765.59617201934;82017.9495512611;82066.58966705189;88833.11166888378;89503;9788.55951482185;9860.753481163028;9922.553485093189;9964.651237206808;10532.104771094542;21889.562208755735;21929.890350548147;21978.560428791334;22050.44873878134;22354.105835766713;7558.622068896533;7616.200298968639;7708.961455192688;7851.057873055156;7876.684932602746;4071.5114186297833;4076.3477843545484;4092.9386059209137;4102.405151253051;4117.526484454266;3570.6429357064085;3586.1931065510053;3609.0255630979486;3609.512715783388;3618.3125206210734;673.7709178879204;677.200902934542;686.7767975408012;693.6739732325799;701.0850839654198;551.448788393886;604;627.2660986645635;627.3196208333583;635.6699078228991;8459;8563.443376180652;8676.132386761274;8787.077356877564;8858.77853053666;597.3996133885418;601.1703848688869;604.9969750151221;609.5032548472981;634.337117711992;3925.156091440354;3986.5614782373914;4039.7980100994832;4081.0817566047403;4128.298189307825;92764;94462;95303;95306.52346738221;96345.51827240818;81038.18961810424;81387.59306203431;82146;82801.17198828055;83759;66186.66906665436;66645.00064998057;67430.66284668545;67670.66164669146;69630;6750.426213771688;7904.20957904228;7951.960240198762;8091.716789912325;8260.504369737835;48865.511344886094;49374.76563085952;49722.25416618826;49785.75107124441;50256.74871625618;58734.65061397496;58966.11550826655;67752;69529;69972.65013674898;10873.782524349626;10966.561337546409;11117.610883619358;11139.275947063416;11475;12004.879951200726;12049.638510844688;12280.01759859227;12488.937555312164;12739.235645861278;11354.205205635526;11397.145214109141;11676.94161529187;11799.997000255074;11999.880001199876;9429.292803039662;11268.774624507629;11563.942180289045;11591.304521728724;12325.75348493043;11241.325520468798;11328;11378.203525753117;11539.653810385702;12167.878321216675;9359;9478.38390504615;9671.806563868824;10019.599216031276;10109.595616175271;8747.387682862392;9384.530773461436;10056.547455364673;10073.899261007296;10077.422515007067 20:09:37 INFO - PROCESS | 1966 | __end_tp_report 20:09:37 INFO - PROCESS | 1966 | __start_cc_report 20:09:37 INFO - PROCESS | 1966 | _x_x_mozilla_cycle_collect,830 20:09:37 INFO - PROCESS | 1966 | __end_cc_report 20:09:37 INFO - PROCESS | 1966 | __startTimestamp1456373377619__endTimestamp 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | ------- Summary: start ------- 20:09:37 INFO - PROCESS | 1966 | Number of tests: 6 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#0] dojo.html Cycles:165 Average:5729.69 Median:5957.82 stddev:664.74 (11.2%) stddev-sans-first:635.25 20:09:37 INFO - PROCESS | 1966 | Values: 3151.0 3460.4 3464.0 3499.4 3500.4 5594.2 5661.4 5666.9 5693.2 5704.7 4919.4 5575.6 5678.3 5679.9 5682.3 5114.7 5145.0 5155.2 5176.9 5240.8 5239.9 5247.5 5250.4 5251.7 5261.7 5148.5 5175.9 5188.5 5216.9 5218.7 5215.3 5263.9 5270.2 5277.0 5334.8 4989.7 5033.2 5112.9 5184.3 5198.3 5560.9 5569.1 5585.8 5633.3 5695.0 6242.8 6245.6 6247.5 6251.3 6272.7 6123.1 6215.2 6276.1 6284.4 6284.9 5780.5 5813.8 5817.9 5837.1 5887.4 6273.8 6305.6 6372.4 6374.2 6385.6 5949.3 6064.8 6179.4 6248.3 6258.7 6235.7 6277.5 6287.7 6297.7 6303.6 6241.8 6252.0 6254.5 6256.3 6273.6 5171.7 6121.3 6146.9 6187.5 6268.7 4900.1 4903.3 4904.5 4906.5 4926.0 3779.4 4365.2 4384.6 4403.5 4414.8 5608.9 5709.4 5743.9 5805.4 5849.8 6230.9 6260.2 6268.0 6294.5 6299.7 5642.0 5738.0 5772.7 5773.2 5773.9 5353.2 5393.2 5393.6 5402.8 5442.2 6347.2 6366.5 6374.8 6389.4 6404.6 6158.2 6236.2 6279.3 6301.7 6318.4 6327.9 6336.0 6336.4 6351.9 6363.9 6144.3 6187.2 6210.1 6233.9 6242.1 6141.9 6191.0 6224.9 6269.6 6282.2 6092.1 6107.8 6121.4 6123.8 6133.2 5957.8 6102.5 6102.9 6109.2 6145.0 5818.3 5981.6 6025.4 6101.5 6105.7 6044.4 6072.8 6112.9 6117.2 6120.7 4768.0 5226.7 5837.1 5910.9 6041.3 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#1] ext.html Cycles:180 Average:63885.33 Median:39967.30 stddev:137301.53 (343.5%) stddev-sans-first:137604.03 20:09:37 INFO - PROCESS | 1966 | Values: 427.4 540.9 546.7 601.1 619.5 29346.3 39401.0 39957.4 39977.2 39999.4 42741.1 43297.6 43327.6 43356.6 43388.7 9522.8 9736.8 9755.7 9763.7 9773.2 9599.8 9763.6 9765.8 9769.7 9779.3 9680.3 9754.2 9760.7 9796.2 9798.9 9667.7 9738.2 9755.4 9759.4 9761.0 9539.0 9678.3 9705.6 9711.7 9732.5 39916.8 40194.0 40416.0 40450.6 40475.4 1851.2 3272.9 3279.7 3355.4 3421.1 23134.0 27504.9 27595.3 28409.4 28975.8 2833.5 2841.4 2861.9 2888.1 2897.4 416947.9 423712.0 425106.0 425116.0 426412.9 59804.7 60085.4 60129.0 60172.0 60247.1 58728.0 58762.4 58835.4 58858.0 59074.4 16287.8 16494.3 16495.8 16501.9 16512.5 12666.3 12718.1 12741.5 12741.9 12755.5 17976.0 18870.3 19045.3 19092.4 19342.3 6740.8 7618.7 8088.6 8105.6 8176.6 923.6 954.5 975.4 1012.3 1045.6 29520.4 29603.3 30814.7 30822.7 32788.2 1075.9 1085.0 1093.3 1128.6 1151.8 12180.1 14411.4 14593.8 14669.7 14785.5 612257.0 662217.0 669253.0 669742.0 672171.0 49185.5 54898.7 55134.9 55903.4 55945.7 1401.9 1419.4 1428.0 1431.3 1433.2 27210.9 28658.0 28871.4 28962.3 29742.1 49891.8 50009.5 50357.5 50405.7 50447.2 422452.0 425144.0 425169.0 425651.0 426176.0 30211.7 30213.4 31595.8 31606.8 31968.5 41688.6 41740.0 43080.4 43216.8 43242.6 33958.2 35098.8 36052.3 36092.5 36182.6 34656.1 35521.6 35629.3 35910.9 35991.0 28574.9 35211.5 35387.9 36821.0 37290.8 30240.4 31215.7 31278.1 31368.4 31402.2 22825.7 23312.5 24496.8 24758.5 25775.4 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#2] jquery.html Cycles:180 Average:31867.05 Median:24783.57 stddev:89341.16 (360.5%) stddev-sans-first:89560.47 20:09:37 INFO - PROCESS | 1966 | Values: 360.5 362.5 362.5 370.1 370.7 15943.8 16552.5 19429.3 19810.9 20958.2 19535.9 19870.5 19883.8 20108.6 20220.5 5126.9 5756.6 6055.9 6067.8 6106.5 3955.0 4463.0 4465.5 4466.8 5917.1 4440.8 6321.7 6614.6 6615.8 6624.6 6277.5 6539.6 6554.7 6560.2 6591.2 5669.5 5681.5 5683.1 5686.1 5689.7 24197.9 24440.4 24768.5 24798.6 26098.5 2063.7 2117.4 2231.6 2316.6 2869.1 14180.4 14831.3 14943.8 14946.9 15224.9 1544.8 1653.4 1764.7 1765.2 1860.2 90776.5 91333.6 102248.0 106047.5 106167.0 10428.2 10801.9 11012.7 11039.7 11067.3 13044.2 13212.4 13214.5 13218.5 13226.0 8369.5 8521.1 8538.9 8600.9 8608.2 8670.5 8690.5 8695.1 8737.7 8757.7 4402.3 4476.6 4489.2 4503.8 4520.7 1482.3 1739.5 1793.6 1821.8 1840.2 879.0 880.5 961.7 974.9 1000.2 15687.5 18739.8 20039.5 20168.5 20211.2 858.5 879.6 943.7 978.6 1001.2 10464.8 10793.5 10814.3 10980.7 11031.8 486767.0 507965.0 508765.0 552300.0 618087.0 99904.5 115812.1 118030.8 119347.0 121706.0 920.6 1036.2 1050.0 1111.2 1113.9 13424.0 18853.8 18930.1 19031.1 19076.1 33268.0 47632.8 48260.3 49057.0 49533.0 68166.0 68638.3 71665.9 72534.6 73484.9 7851.9 8007.2 8077.9 8278.5 8390.0 10505.7 12653.8 13482.5 13545.7 13663.3 10613.9 11356.7 11638.5 11641.2 11668.9 10680.9 11127.7 11226.3 11476.0 11810.5 7478.7 8754.6 9288.5 9572.0 11039.4 7974.8 8028.0 8038.2 8041.0 8215.5 10701.9 11432.3 11716.1 11748.3 11792.7 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#3] mootools.html Cycles:180 Average:6042.55 Median:514.95 stddev:3221.94 (625.7%) stddev-sans-first:3210.44 20:09:37 INFO - PROCESS | 1966 | Values: 1203.7 1490.4 1529.2 1722.3 1905.5 7840.7 7952.0 8577.9 8603.3 8606.1 8344.9 8642.0 8656.4 8667.9 8672.2 2164.2 2216.8 2217.8 2364.4 2472.1 2386.7 2444.2 2447.2 2447.2 2450.5 2418.7 2423.1 2463.6 2467.6 2470.5 2454.3 2465.1 2479.3 2493.6 2495.7 2439.2 2468.5 2475.8 2499.8 2503.6 8818.8 8870.9 8892.7 8893.9 8902.2 5417.7 5496.6 5505.9 5549.2 5562.4 3571.9 3627.3 3696.1 3700.9 3706.9 1046.9 1067.2 1067.6 1095.8 1102.7 10048.0 11976.6 12123.9 12152.8 12174.8 4901.3 4929.3 4972.7 4987.5 5017.6 10291.8 10295.6 10303.0 10313.7 10314.0 5498.6 5507.0 5511.3 5512.9 5515.3 4387.5 4538.9 4747.5 4856.4 4867.3 3939.3 3957.2 3964.1 3993.3 4000.8 1299.7 1304.1 1306.9 1319.8 1320.3 1053.6 1055.9 1079.3 1309.0 1329.3 8128.8 8185.9 8231.5 8234.4 8256.3 443.5 504.3 513.5 516.4 519.7 6184.0 6184.7 6244.3 6259.9 6260.2 10380.5 10697.6 10876.2 10879.4 10897.8 9409.8 10578.7 10585.5 10642.9 10767.5 8047.0 8173.6 8215.6 8278.9 8287.2 8143.6 8185.5 8263.4 8320.2 8321.2 9358.7 9539.8 9814.3 9864.5 9955.0 9750.5 10065.6 10070.8 10232.6 10411.0 6168.8 6840.9 7087.3 7515.2 7676.3 8185.6 8213.8 8249.4 8255.2 8257.1 7215.6 7346.5 7353.6 7477.6 7478.8 7241.5 7262.7 7305.7 7378.4 7406.2 7741.9 7747.0 7783.2 7789.9 7795.4 6749.1 7009.7 7068.5 7075.3 7075.8 7059.0 7133.7 7135.3 7139.8 7141.0 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#4] prototype.html Cycles:180 Average:5677.77 Median:6545.17 stddev:1817.70 (27.8%) stddev-sans-first:1777.14 20:09:37 INFO - PROCESS | 1966 | Values: 284.2 327.2 328.6 333.1 333.7 6429.3 6586.7 6602.3 6635.4 6647.0 6478.6 6522.0 6545.8 6546.0 6552.4 4654.7 4789.4 4790.6 4908.7 4929.8 4860.4 4865.9 4881.1 4907.2 4908.5 4834.7 4856.0 4884.8 4887.4 4888.2 4634.2 4635.1 4738.1 4757.1 4760.9 4068.6 4070.5 4079.8 4084.3 4094.5 6071.8 6120.9 6167.4 6172.3 6202.2 5570.4 5579.3 5581.4 5582.2 5604.2 6802.6 6811.3 6811.5 6819.3 6819.3 3964.4 4206.6 4447.9 4483.1 4511.3 7229.2 7322.6 7334.6 7336.7 7343.7 4575.7 4578.9 4581.8 4584.5 4584.8 4626.2 4640.4 4641.0 4643.0 4649.0 4452.6 5507.9 5510.8 5512.5 5521.9 6716.1 6973.5 6988.4 7008.8 7019.0 1594.8 1604.3 1615.2 1621.4 1622.2 848.5 968.0 994.1 1023.1 1047.7 6448.7 6486.8 6491.5 6507.9 6544.5 7116.2 7133.6 7135.0 7135.1 7148.7 6421.2 6423.9 6436.8 6440.0 6444.5 3626.3 3735.7 3768.5 3780.6 3780.9 7422.4 7441.4 7448.4 7474.7 7475.9 7333.2 7340.3 7350.9 7360.3 7366.8 7370.6 7388.0 7389.8 7393.8 7397.5 6860.7 7098.6 7125.1 7125.3 7134.5 6961.6 7019.5 7019.7 7020.8 7022.0 6016.0 7403.0 7411.1 7426.4 7430.8 4177.4 4378.1 4562.6 4567.3 4571.2 7050.7 7065.8 7067.2 7069.6 7071.7 6761.8 7072.8 7077.4 7080.3 7083.0 7014.9 7034.2 7037.2 7038.3 7044.3 6867.1 6870.3 6875.8 6880.8 6888.1 6768.6 7030.5 7032.3 7041.4 7052.0 6605.3 6717.7 6725.1 6852.3 6855.7 20:09:37 INFO - PROCESS | 1966 | 20:09:37 INFO - PROCESS | 1966 | [#5] yui.html Cycles:180 Average:18659.43 Median:604.50 stddev:26137.04 (4323.8%) stddev-sans-first:26175.55 20:09:37 INFO - PROCESS | 1966 | Values: 695.7 741.4 746.9 765.8 784.1 17510.5 17709.8 17817.6 17826.6 17835.6 16000.8 16069.4 16101.0 16103.3 16240.3 741.2 753.3 893.7 915.4 915.9 895.0 897.8 904.4 907.6 908.3 943.7 949.7 950.7 952.2 952.2 775.8 936.9 938.8 942.5 949.5 699.0 702.3 704.1 705.2 706.9 15265.2 15322.2 15346.2 15365.2 15371.8 12755.6 12808.6 12915.0 13188.3 13244.9 10022.2 10132.2 10245.6 10265.1 10281.0 2637.5 3596.8 3613.2 3646.3 3659.9 80765.6 82017.9 82066.6 88833.1 89503.0 9788.6 9860.8 9922.6 9964.7 10532.1 21889.6 21929.9 21978.6 22050.4 22354.1 7558.6 7616.2 7709.0 7851.1 7876.7 4071.5 4076.3 4092.9 4102.4 4117.5 3570.6 3586.2 3609.0 3609.5 3618.3 673.8 677.2 686.8 693.7 701.1 551.4 604.0 627.3 627.3 635.7 8459.0 8563.4 8676.1 8787.1 8858.8 597.4 601.2 605.0 609.5 634.3 3925.2 3986.6 4039.8 4081.1 4128.3 92764.0 94462.0 95303.0 95306.5 96345.5 81038.2 81387.6 82146.0 82801.2 83759.0 66186.7 66645.0 67430.7 67670.7 69630.0 6750.4 7904.2 7952.0 8091.7 8260.5 48865.5 49374.8 49722.3 49785.8 50256.7 58734.7 58966.1 67752.0 69529.0 69972.7 10873.8 10966.6 11117.6 11139.3 11475.0 12004.9 12049.6 12280.0 12488.9 12739.2 11354.2 11397.1 11676.9 11800.0 11999.9 9429.3 11268.8 11563.9 11591.3 12325.8 11241.3 11328.0 11378.2 11539.7 12167.9 9359.0 9478.4 9671.8 10019.6 10109.6 8747.4 9384.5 10056.5 10073.9 10077.4 20:09:37 INFO - PROCESS | 1966 | -------- Summary: end -------- 20:09:37 INFO - PROCESS | 1966 | 20:09:38 INFO - TEST-INFO | 1966: exit 0 20:09:38 INFO - TEST-OK | dromaeo_css | took 1113638ms 20:09:38 INFO - TEST-START | kraken 20:09:38 INFO - operating with platform_type : mac_ 20:09:38 INFO - Initialising browser for kraken test... 20:09:38 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpbtCcmc/profile http://localhost:49709/getInfo.html) 20:09:40 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 20:09:40 INFO - PROCESS | 1970 | colorDepth:24 20:09:40 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 20:09:40 INFO - PROCESS | 1970 | __metrics 20:09:40 INFO - PROCESS | 1970 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:40 INFO - PROCESS | 1970 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:40 INFO - TEST-INFO | 1970: exit 0 20:09:40 INFO - Browser initialized. 20:09:40 INFO - Running cycle 1/1 for kraken test... 20:09:40 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/T/tmpbtCcmc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:52 INFO - PROCESS | 1972 | RSS: Main: 244604928 20:09:52 INFO - PROCESS | 1972 | 20:09:55 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:56 INFO - PROCESS | 1972 | RSS: Main: 289701888 20:09:56 INFO - PROCESS | 1972 | 20:09:58 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-dft) 20:09:59 INFO - PROCESS | 1972 | RSS: Main: 300396544 20:09:59 INFO - PROCESS | 1972 | 20:10:02 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-fft) 20:10:03 INFO - PROCESS | 1972 | RSS: Main: 286707712 20:10:03 INFO - PROCESS | 1972 | 20:10:05 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49709/tests/kraken/driver.html?testName=audio-oscillator) 20:10:05 INFO - PROCESS | 1972 | RSS: Main: 290701312 20:10:05 INFO - PROCESS | 1972 | 20:10:07 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:10:08 INFO - PROCESS | 1972 | RSS: Main: 291078144 20:10:08 INFO - PROCESS | 1972 | 20:10:11 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-darkroom) 20:10:11 INFO - PROCESS | 1972 | RSS: Main: 291471360 20:10:11 INFO - PROCESS | 1972 | 20:10:14 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49709/tests/kraken/driver.html?testName=imaging-desaturate) 20:10:15 INFO - PROCESS | 1972 | RSS: Main: 290570240 20:10:15 INFO - PROCESS | 1972 | 20:10:18 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49709/tests/kraken/driver.html?testName=json-parse-financial) 20:10:18 INFO - PROCESS | 1972 | RSS: Main: 291180544 20:10:18 INFO - PROCESS | 1972 | 20:10:20 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49709/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:10:20 INFO - PROCESS | 1972 | RSS: Main: 325234688 20:10:20 INFO - PROCESS | 1972 | 20:10:22 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:10:23 INFO - PROCESS | 1972 | RSS: Main: 326250496 20:10:23 INFO - PROCESS | 1972 | 20:10:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:10:25 INFO - PROCESS | 1972 | RSS: Main: 333316096 20:10:25 INFO - PROCESS | 1972 | 20:10:28 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:10:29 INFO - PROCESS | 1972 | RSS: Main: 334618624 20:10:29 INFO - PROCESS | 1972 | 20:10:31 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:32 INFO - PROCESS | 1972 | RSS: Main: 333754368 20:10:32 INFO - PROCESS | 1972 | 20:10:33 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49709/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49709/tests/kraken/driver.html?testName=ai-astar) 20:10:34 INFO - PROCESS | 1972 | RSS: Main: 394465280 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | __start_tp_report 20:10:34 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 20:10:34 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 20:10:34 INFO - PROCESS | 1972 | |i|pagename|runs| 20:10:34 INFO - PROCESS | 1972 | |0;ai-astar;111;107;110;109;109;111;120;162;166;108 20:10:34 INFO - PROCESS | 1972 | |1;audio-beat-detection;174;121;145;157;119;144;138;117;157;118 20:10:34 INFO - PROCESS | 1972 | |2;audio-dft;182;185;191;186;186;184;186;183;180;182 20:10:34 INFO - PROCESS | 1972 | |3;audio-fft;74;71;91;105;81;57;61;79;76;59 20:10:34 INFO - PROCESS | 1972 | |4;audio-oscillator;90;93;128;79;80;92;113;77;79;114 20:10:34 INFO - PROCESS | 1972 | |5;imaging-gaussian-blur;92;91;85;91;86;78;109;140;92;93 20:10:34 INFO - PROCESS | 1972 | |6;imaging-darkroom;98;94;105;139;115;94;94;97;95;88 20:10:34 INFO - PROCESS | 1972 | |7;imaging-desaturate;85;91;90;91;89;88;85;89;90;85 20:10:34 INFO - PROCESS | 1972 | |8;json-parse-financial;54;55;55;54;53;53;55;64;52;52 20:10:34 INFO - PROCESS | 1972 | |9;json-stringify-tinderbox;63;63;79;73;70;66;66;66;67;69 20:10:34 INFO - PROCESS | 1972 | |10;stanford-crypto-aes;84;84;79;83;79;83;84;83;85;83 20:10:34 INFO - PROCESS | 1972 | |11;stanford-crypto-ccm;131;126;128;134;133;132;131;127;124;125 20:10:34 INFO - PROCESS | 1972 | |12;stanford-crypto-pbkdf2;140;128;137;137;139;128;138;139;137;140 20:10:34 INFO - PROCESS | 1972 | |13;stanford-crypto-sha256-iterative;66;67;67;67;68;67;67;66;67;68 20:10:34 INFO - PROCESS | 1972 | __end_tp_report 20:10:34 INFO - PROCESS | 1972 | __start_cc_report 20:10:34 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,1153 20:10:34 INFO - PROCESS | 1972 | __end_cc_report 20:10:34 INFO - PROCESS | 1972 | __startTimestamp1456373434060__endTimestamp 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | ------- Summary: start ------- 20:10:34 INFO - PROCESS | 1972 | Number of tests: 14 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#0] ai-astar Cycles:10 Average:121.30 Median:111.00 stddev:22.80 (20.5%) stddev-sans-first:23.88 20:10:34 INFO - PROCESS | 1972 | Values: 111.0 107.0 110.0 109.0 109.0 111.0 120.0 162.0 166.0 108.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:144.50 stddev:19.96 (13.8%) stddev-sans-first:16.67 20:10:34 INFO - PROCESS | 1972 | Values: 174.0 121.0 145.0 157.0 119.0 144.0 138.0 117.0 157.0 118.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.50 stddev:3.06 (1.7%) stddev-sans-first:3.11 20:10:34 INFO - PROCESS | 1972 | Values: 182.0 185.0 191.0 186.0 186.0 184.0 186.0 183.0 180.0 182.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#3] audio-fft Cycles:10 Average:75.40 Median:75.00 stddev:14.91 (19.9%) stddev-sans-first:15.80 20:10:34 INFO - PROCESS | 1972 | Values: 74.0 71.0 91.0 105.0 81.0 57.0 61.0 79.0 76.0 59.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.50 stddev:17.86 (22.5%) stddev-sans-first:18.87 20:10:34 INFO - PROCESS | 1972 | Values: 90.0 93.0 128.0 79.0 80.0 92.0 113.0 77.0 79.0 114.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:91.00 stddev:17.45 (19.2%) stddev-sans-first:18.46 20:10:34 INFO - PROCESS | 1972 | Values: 92.0 91.0 85.0 91.0 86.0 78.0 109.0 140.0 92.0 93.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#6] imaging-darkroom Cycles:10 Average:101.90 Median:94.00 stddev:15.00 (16.0%) stddev-sans-first:15.84 20:10:34 INFO - PROCESS | 1972 | Values: 98.0 94.0 105.0 139.0 115.0 94.0 94.0 97.0 95.0 88.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#7] imaging-desaturate Cycles:10 Average:88.30 Median:89.50 stddev:2.45 (2.7%) stddev-sans-first:2.29 20:10:34 INFO - PROCESS | 1972 | Values: 85.0 91.0 90.0 91.0 89.0 88.0 85.0 89.0 90.0 85.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:54.50 stddev:3.47 (6.4%) stddev-sans-first:3.67 20:10:34 INFO - PROCESS | 1972 | Values: 54.0 55.0 55.0 54.0 53.0 53.0 55.0 64.0 52.0 52.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:4.87 (7.2%) stddev-sans-first:4.79 20:10:34 INFO - PROCESS | 1972 | Values: 63.0 63.0 79.0 73.0 70.0 66.0 66.0 66.0 67.0 69.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.50 stddev:2.06 (2.5%) stddev-sans-first:2.13 20:10:34 INFO - PROCESS | 1972 | Values: 84.0 84.0 79.0 83.0 79.0 83.0 84.0 83.0 85.0 83.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:131.00 stddev:3.54 (2.7%) stddev-sans-first:3.69 20:10:34 INFO - PROCESS | 1972 | Values: 131.0 126.0 128.0 134.0 133.0 132.0 131.0 127.0 124.0 125.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:138.50 stddev:4.52 (3.3%) stddev-sans-first:4.59 20:10:34 INFO - PROCESS | 1972 | Values: 140.0 128.0 137.0 137.0 139.0 128.0 138.0 139.0 137.0 140.0 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - PROCESS | 1972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 20:10:34 INFO - PROCESS | 1972 | Values: 66.0 67.0 67.0 67.0 68.0 67.0 67.0 66.0 67.0 68.0 20:10:34 INFO - PROCESS | 1972 | -------- Summary: end -------- 20:10:34 INFO - PROCESS | 1972 | 20:10:34 INFO - TEST-INFO | 1972: exit 0 20:10:34 INFO - TEST-OK | kraken | took 56633ms 20:10:34 INFO - SUITE-END | took 1170s 20:10:35 INFO - Completed test suite (00:19:30) 20:10:35 INFO - Working with test: dromaeo_css 20:10:35 INFO - Generating results file: dromaeo_css 20:10:35 INFO - Working with test: kraken 20:10:35 INFO - Generating results file: kraken 20:10:35 INFO - javascript benchmark 20:10:35 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:35 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 20:10:35 INFO - process_Request line: dromaeo_css 7487.61 graph.html#tests=[[72,64,59]] 20:10:35 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:10:35 INFO - process_Request line: kraken 1438.60 graph.html#tests=[[232,64,59]] 20:10:35 INFO - RETURN: dromaeo_css: 7487.61 20:10:35 INFO - RETURN: kraken: 1438.60 20:10:35 INFO - javascript benchmark 20:10:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3151.0, 3460.4463285874267, 3463.982680086599, 3499.3701133795907, 3500.3874321993644, 5594.24477695511, 5661.4055524169935, 5666.914996275054, 5693.174489698991, 5704.686242256679, 4919.434265059519, 5575.609707320489, 5678.318601767794, 5679.8580035499135, 5682.261306030221, 5114.744262786864, 5145.0481660892665, 5155.175171972485, 5176.948230517703, 5240.79036838526, 5239.947600524003, 5247.527722504974, 5250.422453530108, 5251.658642188246, 5261.736913154346, 5148.536631703146, 5175.87060323493, 5188.455212202721, 5216.895662086756, 5218.686878787266, 5215.322008138955, 5263.947360526384, 5270.209468579706, 5277.023750606112, 5334.786608535654, 4989.65072444929, 5033.219850923113, 5112.923306150411, 5184.274201611777, 5198.324217851693, 5560.944390556083, 5569.053260945609, 5585.832425027215, 5633.324001119892, 5695.0, 6242.812715618538, 6245.6252624842655, 6247.531435142382, 6251.3123556408755, 6272.65500397478, 6123.130109042722, 6215.223097112861, 6276.089966954812, 6284.434400903895, 6284.905726414107, 5780.479756821865, 5813.82558523245, 5817.94182058174, 5837.124431335291, 5887.411258874121, 6273.780417685451, 6305.621662700252, 6372.36276372359, 6374.203224596926, 6385.648789316632, 5949.315828679671, 6064.848378790477, 6179.351168127372, 6248.250209974832, 6258.74965001404, 6235.688215589203, 6277.466415354746, 6287.717052732546, 6297.685115744194, 6303.590266632654, 6241.812745617639, 6251.9687401563615, 6254.499640028786, 6256.311805701369, 6273.560850740404, 5171.663841850268, 6121.326654068049, 6146.924288249538, 6187.535934804818, 6268.717907694165, 4900.093482705711, 4903.289023091632, 4904.5340692634145, 4906.484819093944, 4925.975370123127, 3779.3764028934916, 4365.236083685342, 4384.56154384559, 4403.515613282536, 4414.779261037, 5608.943910560843, 5709.371969083398, 5743.913841292384, 5805.448482394166, 5849.795257165979, 6230.875382492325, 6260.186175797208, 6268.028455589391, 6294.464970477469, 6299.653519056405, 5642.04085305499, 5738.0, 5772.740226689809, 5773.191753154561, 5773.8556536086935, 5353.2237825515085, 5393.164059570773, 5393.649412788234, 5402.8109016185035, 5442.23808666779, 6347.206599175103, 6366.458850997532, 6374.840628984312, 6389.361063893573, 6404.615723056631, 6158.199434073721, 6236.220472440945, 6279.277883043325, 6301.6534090625455, 6318.368163183645, 6327.936720632735, 6335.968320158554, 6336.366363363811, 6351.872962540631, 6363.872722545616, 6144.262688477412, 6187.1647327612, 6210.130581718473, 6233.937660623335, 6242.094896240111, 6141.9385806143155, 6191.0, 6224.875502489835, 6269.592476489013, 6282.246130464374, 6092.055731361646, 6107.816765497042, 6121.387861213843, 6123.7550497981365, 6133.172021777182, 5957.821265361873, 6102.4507794298725, 6102.877942441038, 6109.236345456818, 6144.969275153596, 5818.330891947311, 5981.581289309881, 6025.397460254115, 6101.45934676866, 6105.664188469676, 6044.425779550936, 6072.78745243932, 6112.8777424452155, 6117.204763380732, 6120.663363515049, 4768.0, 5226.712530810842, 5837.09525023622, 5910.940890591211, 6041.284927575101], "unit": "score", "name": "dojo.html", "value": 5686.630777393052}, {"lowerIsBetter": false, "replicates": [427.4187105536472, 540.8728948697055, 546.7047794191137, 601.0953514959986, 619.5198720991232, 29346.2663433414, 39401.0, 39957.40063899044, 39977.20045599086, 39999.400008999815, 42741.145177096514, 43297.56702432975, 43327.56672433275, 43356.56643433565, 43388.6983390498, 9522.80954380912, 9736.805263894717, 9755.707328780149, 9763.707088787312, 9773.169280611157, 9599.760005999871, 9763.609455621767, 9765.755856103618, 9769.706908792712, 9779.315447918649, 9680.27397945157, 9754.219662426989, 9760.658376956808, 9796.167325777282, 9798.853017204749, 9667.70996870095, 9738.220942324668, 9755.36590121647, 9759.414435133915, 9760.95119524405, 9539.046095390475, 9678.27412944032, 9705.61177552897, 9711.708648740478, 9732.464714440703, 39916.80041599803, 40194.0, 40416.0, 40450.595494044974, 40475.39286910699, 1851.2046809317892, 3272.8527216275324, 3279.6556361582166, 3355.379254837863, 3421.1447138215444, 23133.958971846307, 27504.862475687492, 27595.310117247027, 28409.43181136366, 28975.84096636132, 2833.4758069757163, 2841.4459180459817, 2861.899833505838, 2888.0613800514707, 2897.3915477749697, 416947.91526042175, 423712.0, 425106.0, 425116.0, 426412.86793566146, 59804.70097649484, 60085.39914600886, 60129.0, 60172.0, 60247.09629355476, 58728.0, 58762.41237587655, 58835.41164588385, 58858.0, 59074.40925590689, 16287.837121628869, 16494.2577584009, 16495.752563711554, 16501.91749041247, 16512.51387375142, 12666.303353315656, 12718.109732318833, 12741.490340386466, 12741.936290318488, 12755.489780408865, 17976.030698852504, 18870.3395381161, 19045.333413330467, 19092.427227183205, 19342.32301869428, 6740.764073257511, 7618.733344332922, 8088.636011379502, 8105.554194519358, 8176.6320515576945, 923.6351641101727, 954.5322791831952, 975.4147511493047, 1012.3470361616716, 1045.6078970386104, 29520.409591808042, 29603.25991850178, 30814.69185308118, 30822.69177308243, 32788.180295492806, 1075.9127293051456, 1084.9891501084887, 1093.278436232099, 1128.5767837061103, 1151.8157094864782, 12180.147389682814, 14411.42354305837, 14593.78109328361, 14669.706605867823, 14785.482508112165, 612257.0, 662217.0, 669253.0, 669742.0, 672171.0, 49185.50814491881, 54898.72550637221, 55134.89730205454, 55903.440965590635, 55945.720271398386, 1401.8668226518464, 1419.3825685826698, 1428.0, 1431.2986636548226, 1433.197409450711, 27210.863945680147, 28658.0, 28871.42257154803, 28962.27594310159, 29742.10773676793, 49891.750541247064, 50009.499905000484, 50357.49642503528, 50405.74797126138, 50447.24329134992, 422452.0, 425144.0, 425169.0, 425651.0, 426176.0, 30211.697883021767, 30213.395732085675, 31595.84202078975, 31606.841965790023, 31968.52047219247, 41688.58311416968, 41740.0, 43080.35379469373, 43216.78391608022, 43242.56757432511, 33958.15104622404, 35098.82450587731, 36052.27895442024, 36092.45861312135, 36182.63817361898, 34656.133596659274, 35521.644783551834, 35629.28741425105, 35910.92267231987, 35991.0, 28574.85712571507, 35211.47182792209, 35387.938361849185, 36821.0, 37290.81354593318, 30240.395192095595, 31215.68784312128, 31278.06165815029, 31368.37263254768, 31402.21494462657, 22825.657615135453, 23312.46692824585, 24496.75503245016, 24758.50482990366, 25775.355616109], "unit": "score", "name": "ext.html", "value": 19369.328875755666}, {"lowerIsBetter": false, "replicates": [360.4539123228309, 362.5196614485807, 362.52147165741235, 370.0508196476039, 370.6719553195421, 15943.840561594381, 16552.503424897273, 19429.31997380092, 19810.900945495272, 20958.16167353306, 19535.902320488414, 19870.50323741907, 19883.801161988376, 20108.597828043432, 20220.494487637818, 5126.897462050775, 5756.597038207327, 6055.909161362583, 6067.7572897084065, 6106.450419462248, 3954.9604503955024, 4462.955370446286, 4465.508794032654, 4466.754328511931, 5917.142014407908, 4440.844570440036, 6321.7471301148125, 6614.570052946543, 6615.768448104317, 6624.5694029888145, 6277.5291853110975, 6539.574927629689, 6554.70503827329, 6560.179977502812, 6591.242007169165, 5669.489745922846, 5681.545476361881, 5683.062294721407, 5686.147077938301, 5689.687067211302, 24197.87901060501, 24440.38899027521, 24768.5046299073, 24798.628020579705, 26098.478030439474, 2063.66981282994, 2117.4071260047212, 2231.564844855254, 2316.6177580699164, 2869.0675530452686, 14180.401975102597, 14831.332590033366, 14943.80905022377, 14946.87898407613, 15224.858135639872, 1544.7528395456673, 1653.4460955579896, 1764.7176451767784, 1765.161548264564, 1860.2187081425834, 90776.54611726965, 91333.62999555012, 102247.97752022534, 106047.46976265147, 106166.99999999923, 10428.217883658755, 10801.945990269998, 11012.669619911416, 11039.668809935714, 11067.280626759395, 13044.217346959213, 13212.405441755143, 13214.537491187955, 13218.537351192854, 13226.0, 8369.49783013021, 8521.147885211429, 8538.87191692125, 8600.913990860012, 8608.182222688834, 8670.523121228267, 8690.478571285617, 8695.08701586337, 8737.694180703773, 8757.693480728143, 4402.295632698753, 4476.612250202447, 4489.214387482178, 4503.752293623882, 4520.706154099973, 1482.2736858939043, 1739.4694618141589, 1793.6233390988039, 1821.7813862336338, 1840.162725959685, 878.9780255493536, 880.5333173418098, 961.6634178037771, 974.8683927669674, 1000.2498126405196, 15687.4509392173, 18739.75379295953, 20039.499012524804, 20168.49578760543, 20211.191552338038, 858.4891989266376, 879.5514287713312, 943.7074506902882, 978.6379039755336, 1001.1990407673832, 10464.843027354596, 10793.46383046688, 10814.31858910671, 10980.670579882617, 11031.767284556672, 486767.0, 507965.0, 508765.0, 552300.0, 618087.0, 99904.50047749715, 115812.10469738324, 118030.81969180198, 119347.0, 121706.0, 920.5673333533229, 1036.212478516318, 1049.9842502362471, 1111.2276967507505, 1113.8886111388797, 13424.0, 18853.811461885205, 18930.053497324803, 19031.143598537823, 19076.141573628942, 33268.0, 47632.7618361906, 48260.27609585789, 49057.018859621894, 49533.0, 68166.0, 68638.31361686319, 71665.92501112384, 72534.63732681303, 73484.89772653308, 7851.9214807851195, 8007.199280072179, 8077.878831817645, 8278.544680042656, 8390.0, 10505.68482945513, 12653.810192846931, 13482.52811151605, 13545.661358466117, 13663.316834158451, 10613.9469302653, 11356.716082098013, 11638.5344586219, 11641.243319184226, 11668.88331116678, 10680.8931910683, 11127.72180695489, 11226.326420414802, 11476.0, 11810.527578896748, 7478.70085196586, 8754.649814007369, 9288.535573221447, 9571.952140239533, 11039.448027598428, 7974.840503189787, 8028.0, 8038.196180381915, 8040.959795200986, 8215.465994710325, 10701.892981070401, 11432.314061156358, 11716.121290903046, 11748.29510229389, 11792.70518237051], "unit": "score", "name": "jquery.html", "value": 9309.266032475662}, {"lowerIsBetter": false, "replicates": [1203.7231436769537, 1490.3665941974662, 1529.1895295493393, 1722.3282919661335, 1905.4569447707406, 7840.6863725450985, 7951.966244388236, 8577.914220857789, 8603.268722158607, 8606.139386061406, 8344.91655083449, 8642.0, 8656.394052416334, 8667.869981950276, 8672.219500244977, 2164.2316977473006, 2216.767239439852, 2217.84475086744, 2364.385259832443, 2472.11004038546, 2386.677798497207, 2444.1934161726676, 2447.155731272717, 2447.2413551799, 2450.546648869956, 2418.6734790803193, 2423.09134074722, 2463.6304554316816, 2467.629855521677, 2470.493548822487, 2454.3373289211813, 2465.1248806673552, 2479.2686157583466, 2493.551160791057, 2495.700515938081, 2439.1950656283384, 2468.543319485901, 2475.7648023437923, 2499.7500249975037, 2503.6369726389753, 8818.823623527558, 8870.911290887074, 8892.73321800347, 8893.866592001124, 8902.198802107776, 5417.674939503642, 5496.615236933416, 5505.862353441156, 5549.1676248562635, 5562.443755624446, 3571.8749843755604, 3627.310810945938, 3696.057505336149, 3700.85196592136, 3706.944395834065, 1046.9267151299412, 1067.1889364083274, 1067.6049861551276, 1095.775366049958, 1102.6581759654453, 10048.0, 11976.58081967127, 12123.87876121245, 12152.817707734392, 12174.81737773934, 4901.3383193268455, 4929.3345398371475, 4972.701637901738, 4987.476314986947, 5017.623678224075, 10291.845622315672, 10295.639652612123, 10303.0, 10313.690589282334, 10314.02016808402, 5498.560115190775, 5507.0, 5511.283533140666, 5512.91730624041, 5515.283013208337, 4387.473503179639, 4538.88652783683, 4747.525247475225, 4856.417229932431, 4867.269909513601, 3939.2712348215673, 3957.1887763008513, 3964.147708242742, 3993.281209382339, 4000.7799571023293, 1299.6555912682957, 1304.0871390027019, 1306.9150505217322, 1319.7756381415184, 1320.306838909561, 1053.6154303679255, 1055.9049685528187, 1079.2768844873954, 1309.044397589765, 1329.2954733991, 8128.75613731589, 8185.918140818635, 8231.46495477792, 8234.423590348619, 8256.25693687571, 443.45676546230607, 504.2738456622452, 513.5403813586819, 516.367449873909, 519.6959778529603, 6184.0, 6184.670295886406, 6244.344343843922, 6259.906101408392, 6260.154879091265, 10380.532876020598, 10697.55582996301, 10876.18428617841, 10879.401632910265, 10897.782044359068, 9409.76475588102, 10578.735531611617, 10585.4707264638, 10642.946785266024, 10767.461626918623, 8047.0, 8173.591320433955, 8215.58922053895, 8278.917210827934, 8287.212714792086, 8143.5928203590765, 8185.549794761345, 8263.421560490708, 8320.21115460179, 8321.16788321163, 9358.719238422858, 9539.761505962406, 9814.312998090065, 9864.457454840052, 9954.950225248827, 9750.512474376395, 10065.597376104874, 10070.8489372658, 10232.64185753495, 10411.0, 6168.784092556739, 6840.931590684029, 7087.255838136922, 7515.248475152441, 7676.347510461674, 8185.590720463834, 8213.753587392388, 8249.381296402913, 8255.215754503313, 8257.133001034805, 7215.639218039182, 7346.52247603904, 7353.632318384166, 7477.588732619758, 7478.775636730907, 7241.493095483265, 7262.709491620276, 7305.707771689073, 7378.372838308804, 7406.222346653739, 7741.922580774345, 7746.961265193638, 7783.182765809508, 7789.883151752615, 7795.376369890509, 6749.122614060141, 7009.684564194726, 7068.469864760061, 7075.292470752884, 7075.787726368218, 7059.011738356737, 7133.714651413885, 7135.286471352823, 7139.785806425815, 7141.0], "unit": "score", "name": "mootools.html", "value": 4820.308578594456}, {"lowerIsBetter": false, "replicates": [284.221233819335, 327.16083246472795, 328.62044338788695, 333.09896729347105, 333.68966860819427, 6429.324920883304, 6586.736530538773, 6602.273749887515, 6635.445353538892, 6646.966765166179, 6478.643674597907, 6522.0, 6545.8363540911505, 6546.0, 6552.3775241352, 4654.6974446661025, 4789.449213340458, 4790.568848803607, 4908.705477671351, 4929.827456039039, 4860.368152140234, 4865.859022030313, 4881.096997055538, 4907.2393778964315, 4908.533689299511, 4834.661573689843, 4855.951440485585, 4884.804607815683, 4887.3890763654545, 4888.242322440027, 4634.189016922025, 4635.072985402916, 4738.147133515966, 4757.119932812441, 4760.904781904343, 4068.5931406859077, 4070.5115386153557, 4079.8164082616354, 4084.264832330179, 4094.488188976378, 6071.848203794896, 6120.938790612126, 6167.383261673796, 6172.290186628506, 6202.19371481709, 5570.442955704438, 5579.274694289757, 5581.441855814427, 5582.246396736429, 5604.187392828017, 6802.557833740791, 6811.318868113199, 6811.489138314597, 6819.283975182584, 6819.283975182584, 3964.444977703124, 4206.642435392995, 4447.888802779924, 4483.125790470859, 4511.255642818931, 7229.1686456057705, 7322.560646361182, 7334.559926404433, 7336.706531738724, 7343.7062517499235, 4575.679702420865, 4578.908421831545, 4581.785826755912, 4584.472785629629, 4584.839530616479, 4626.21354369758, 4640.419947506562, 4641.002184530342, 4643.0, 4649.04694537619, 4452.621527170162, 5507.917381239285, 5510.8071217507195, 5512.503874651301, 5521.889562208814, 6716.126903502513, 6973.5118541701595, 6988.371046605728, 7008.789736307919, 7019.017337572744, 1594.7767312576248, 1604.2620394618373, 1615.2246921477756, 1621.440602991966, 1622.1889055472263, 848.4951453884929, 967.9612815487443, 994.0606127209862, 1023.1201166996377, 1047.659510659039, 6448.677566121675, 6486.772962946368, 6491.545591808528, 6507.9023814642815, 6544.509161812883, 7116.181639111568, 7133.607651579109, 7135.001099846026, 7135.143782746104, 7148.678309476086, 6421.21148522374, 6423.935760642427, 6436.839079022968, 6440.0, 6444.45222156122, 3626.2928728897614, 3735.701143908481, 3768.491253680773, 3780.640839120279, 3780.8865734028022, 7422.443316751157, 7441.441891858024, 7448.4041276697735, 7474.654562178751, 7475.8504829903095, 7333.240022394587, 7340.302671246223, 7350.889736653848, 7360.300771426706, 7366.815829604196, 7370.557766534025, 7387.963060184557, 7389.81525461857, 7393.81515462107, 7397.482176247611, 6860.656967151723, 7098.609576473137, 7125.073740413713, 7125.251848556034, 7134.46491513149, 6961.6171110587375, 7019.508634395544, 7019.719211231698, 7020.7542736006035, 7021.964890175516, 6015.969920150371, 7403.0, 7411.1477180124975, 7426.405887529093, 7430.814229644086, 4177.352510360899, 4378.080603073263, 4562.61217796491, 4567.337736028324, 4571.1543364477675, 7050.682719277747, 7065.788026359011, 7067.222605513287, 7069.575825450489, 7071.71713131469, 6761.797146085625, 7072.7818842427605, 7077.363037326665, 7080.327368899946, 7082.964585177041, 7014.894776578458, 7034.226235114235, 7037.190723066708, 7038.2961703829205, 7044.260352662896, 6867.141607299088, 6870.31296870309, 6875.759348422981, 6880.798144593682, 6888.104546408935, 6768.627725475146, 7030.50786444944, 7032.331928466788, 7041.401480874183, 7051.964740176266, 6605.2734199239, 6717.697703603448, 6725.092112564741, 6852.280510546321, 6855.691493882887], "unit": "score", "name": "prototype.html", "value": 5059.197613131142}, {"lowerIsBetter": false, "replicates": [695.7112798188751, 741.436508253727, 746.8543633991374, 765.7702689193243, 784.0982869699841, 17510.474685759433, 17709.822901770993, 17817.554561135978, 17826.643467130667, 17835.554111147194, 16000.83999160008, 16069.357225710957, 16101.0339379637, 16103.275352609131, 16240.269187886544, 741.2217171969437, 753.3370633842238, 893.678275820704, 915.4095608332622, 915.9358844880861, 895.0, 897.833900728364, 904.4030939579878, 907.591583787295, 908.2643059122099, 943.6744323208482, 949.6676163342844, 950.7290422229665, 952.1668540027476, 952.2429668413594, 775.8215610409637, 936.9344145909789, 938.7512309238023, 942.5334459442552, 949.4920217683575, 698.9895151572731, 702.3292755418563, 704.0741425026074, 705.2418649951322, 706.8974998625222, 15265.23673816316, 15322.23388830554, 15346.232688365648, 15365.154916479589, 15371.769423458658, 12755.61733148007, 12808.551700690432, 12915.0, 13188.274644894527, 13244.86755132446, 10022.198224142125, 10132.226860299417, 10245.641402550875, 10265.127464165555, 10281.0, 2637.4593208392234, 3596.7841929484052, 3613.1509095362567, 3646.3254297954963, 3659.9268014639824, 80765.59617201934, 82017.9495512611, 82066.58966705189, 88833.11166888378, 89503.0, 9788.55951482185, 9860.753481163028, 9922.553485093189, 9964.651237206808, 10532.104771094542, 21889.562208755735, 21929.890350548147, 21978.560428791334, 22050.44873878134, 22354.105835766713, 7558.622068896533, 7616.200298968639, 7708.961455192688, 7851.057873055156, 7876.684932602746, 4071.5114186297833, 4076.3477843545484, 4092.9386059209137, 4102.405151253051, 4117.526484454266, 3570.6429357064085, 3586.1931065510053, 3609.0255630979486, 3609.512715783388, 3618.3125206210734, 673.7709178879204, 677.200902934542, 686.7767975408012, 693.6739732325799, 701.0850839654198, 551.448788393886, 604.0, 627.2660986645635, 627.3196208333583, 635.6699078228991, 8459.0, 8563.443376180652, 8676.132386761274, 8787.077356877564, 8858.77853053666, 597.3996133885418, 601.1703848688869, 604.9969750151221, 609.5032548472981, 634.337117711992, 3925.156091440354, 3986.5614782373914, 4039.7980100994832, 4081.0817566047403, 4128.298189307825, 92764.0, 94462.0, 95303.0, 95306.52346738221, 96345.51827240818, 81038.18961810424, 81387.59306203431, 82146.0, 82801.17198828055, 83759.0, 66186.66906665436, 66645.00064998057, 67430.66284668545, 67670.66164669146, 69630.0, 6750.426213771688, 7904.20957904228, 7951.960240198762, 8091.716789912325, 8260.504369737835, 48865.511344886094, 49374.76563085952, 49722.25416618826, 49785.75107124441, 50256.74871625618, 58734.65061397496, 58966.11550826655, 67752.0, 69529.0, 69972.65013674898, 10873.782524349626, 10966.561337546409, 11117.610883619358, 11139.275947063416, 11475.0, 12004.879951200726, 12049.638510844688, 12280.01759859227, 12488.937555312164, 12739.235645861278, 11354.205205635526, 11397.145214109141, 11676.94161529187, 11799.997000255074, 11999.880001199876, 9429.292803039662, 11268.774624507629, 11563.942180289045, 11591.304521728724, 12325.75348493043, 11241.325520468798, 11328.0, 11378.203525753117, 11539.653810385702, 12167.878321216675, 9359.0, 9478.38390504615, 9671.806563868824, 10019.599216031276, 10109.595616175271, 8747.387682862392, 9384.530773461436, 10056.547455364673, 10073.899261007296, 10077.422515007067], "unit": "score", "name": "yui.html", "value": 7046.664285944312}], "name": "dromaeo_css", "value": 7487.612339403704}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 110.0, 109.0, 109.0, 111.0, 120.0, 162.0, 166.0, 108.0], "unit": "score", "name": "ai-astar", "value": 121.3}, {"lowerIsBetter": true, "replicates": [174.0, 121.0, 145.0, 157.0, 119.0, 144.0, 138.0, 117.0, 157.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 139.0}, {"lowerIsBetter": true, "replicates": [182.0, 185.0, 191.0, 186.0, 186.0, 184.0, 186.0, 183.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 91.0, 105.0, 81.0, 57.0, 61.0, 79.0, 76.0, 59.0], "unit": "score", "name": "audio-fft", "value": 75.4}, {"lowerIsBetter": true, "replicates": [90.0, 93.0, 128.0, 79.0, 80.0, 92.0, 113.0, 77.0, 79.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 85.0, 91.0, 86.0, 78.0, 109.0, 140.0, 92.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.7}, {"lowerIsBetter": true, "replicates": [98.0, 94.0, 105.0, 139.0, 115.0, 94.0, 94.0, 97.0, 95.0, 88.0], "unit": "score", "name": "imaging-darkroom", "value": 101.9}, {"lowerIsBetter": true, "replicates": [85.0, 91.0, 90.0, 91.0, 89.0, 88.0, 85.0, 89.0, 90.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 88.3}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 55.0, 54.0, 53.0, 53.0, 55.0, 64.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.7}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 79.0, 73.0, 70.0, 66.0, 66.0, 66.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 79.0, 83.0, 79.0, 83.0, 84.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [131.0, 126.0, 128.0, 134.0, 133.0, 132.0, 131.0, 127.0, 124.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [140.0, 128.0, 137.0, 137.0, 139.0, 128.0, 138.0, 139.0, 137.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1438.6}]} 20:10:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1438.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7487.61"}}} 20:10:35 INFO - Return code: 0 20:10:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:10:35 INFO - # TBPL SUCCESS # 20:10:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:10:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:10:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:10:35 INFO - 2016-02-24 20:10:35.470 screenresolution[1976:12339] starting screenresolution argv=screenresolution get 20:10:35 INFO - 2016-02-24 20:10:35.472 screenresolution[1976:12339] Display 0: 1600x1200x32@60 20:10:35 INFO - 2016-02-24 20:10:35.478 screenresolution[1977:12342] starting screenresolution argv=screenresolution list 20:10:35 INFO - Available Modes on Display 0 20:10:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:10:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:10:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:10:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:10:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:10:35 INFO - Intel Iris: 20:10:35 INFO - Chipset Model: Intel Iris 20:10:35 INFO - Type: GPU 20:10:35 INFO - Bus: Built-In 20:10:35 INFO - VRAM (Dynamic, Max): 1536 MB 20:10:35 INFO - Vendor: Intel (0x8086) 20:10:35 INFO - Device ID: 0x0a2e 20:10:35 INFO - Revision ID: 0x0009 20:10:35 INFO - Displays: 20:10:35 INFO - Display: 20:10:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:10:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:10:35 INFO - Display Serial Number: 1600x1200 60 20:10:35 INFO - Main Display: Yes 20:10:35 INFO - Mirror: Off 20:10:35 INFO - Online: Yes 20:10:35 INFO - Rotation: Supported 20:10:35 INFO - Return code: 0 20:10:35 INFO - Running post-action listener: _resource_record_post_action 20:10:35 INFO - Running post-run listener: _resource_record_post_run 20:10:36 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2609152; Write bytes: 707765248; Read time: 41; Write time: 2159 20:10:36 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 382583296; Write bytes: 377437184; Read time: 28378; Write time: 680 20:10:36 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2609152; Write bytes: 300730368; Read time: 41; Write time: 1412 20:10:36 INFO - Running post-run listener: _upload_blobber_files 20:10:36 INFO - Blob upload gear active. 20:10:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:10:36 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 20:10:36 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'] 20:10:36 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 20:10:37 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:10:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:10:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:37 INFO - (blobuploader) - INFO - Done attempting. 20:10:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:10:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:10:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:38 INFO - (blobuploader) - INFO - Done attempting. 20:10:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:38 INFO - Return code: 0 20:10:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:10:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42508e228ce4bb70fdc909edb72294134a6aec90ca48f9adcad72427566076fb66700a2289bb06f166348180a6c4d3b324a9ccf1224d32ef9599a7dfcfacee1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2e119dc2ba0f4975b5140968d44680e1cef7479bf795f3e4cce7011e7f384af1016bcfb14267057ebe54201342abd5c2450a0bcc76770695a83c3aa0cf8a94e"} 20:10:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:10:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:10:38 INFO - Contents: 20:10:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42508e228ce4bb70fdc909edb72294134a6aec90ca48f9adcad72427566076fb66700a2289bb06f166348180a6c4d3b324a9ccf1224d32ef9599a7dfcfacee1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2e119dc2ba0f4975b5140968d44680e1cef7479bf795f3e4cce7011e7f384af1016bcfb14267057ebe54201342abd5c2450a0bcc76770695a83c3aa0cf8a94e"} 20:10:38 INFO - Running post-run listener: copy_logs_to_upload_dir 20:10:38 INFO - Copying logs to upload dir... 20:10:38 INFO - mkdir: /builds/slave/test/build/upload/logs 20:10:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.179922 ========= master_lag: 5.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-24 20:10:44.007298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 20:10:44.010494) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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/42508e228ce4bb70fdc909edb72294134a6aec90ca48f9adcad72427566076fb66700a2289bb06f166348180a6c4d3b324a9ccf1224d32ef9599a7dfcfacee1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2e119dc2ba0f4975b5140968d44680e1cef7479bf795f3e4cce7011e7f384af1016bcfb14267057ebe54201342abd5c2450a0bcc76770695a83c3aa0cf8a94e"} build_url:https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/BAG_Fx-iSDWGbvlaG40v1Q/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42508e228ce4bb70fdc909edb72294134a6aec90ca48f9adcad72427566076fb66700a2289bb06f166348180a6c4d3b324a9ccf1224d32ef9599a7dfcfacee1d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a2e119dc2ba0f4975b5140968d44680e1cef7479bf795f3e4cce7011e7f384af1016bcfb14267057ebe54201342abd5c2450a0bcc76770695a83c3aa0cf8a94e"}' ========= master_lag: 0.98 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 20:10:45.000785) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 20:10:45.001153) ========= 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.atmERWiPUZ/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.82RtjsYIdr/Listeners TMPDIR=/var/folders/15/kcx20ryj2rs9kb6sgv5k9lrm00000w/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.005216 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 20:10:45.045160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 20:10:45.045485) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 20:10:45.045946) ========= ========= Total master_lag: 6.36 =========