builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0057 starttime: 1458173335.61 results: success (0) buildid: 20160316085442 builduid: ebfc4d8c48dc4412b2f85d76adab9f30 revision: 72cd7ab94678b6bc2e607702cc398a378a1787a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:55.614534) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:55.614986) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:55.615271) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005076 basedir: '/builds/slave/test' ========= master_lag: 0.63 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:56.249112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:56.249421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.092556) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.092819) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.006196 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.225197) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.225486) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.225826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.226145) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-16 17:08:57-- 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% 12.9M=0.001s 2016-03-16 17:08:57 (12.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.466248 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:08:57.946877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-16 17:08:57.947151) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.025838 ========= master_lag: 3.51 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 3 secs) (at 2016-03-16 17:09:01.478457) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-16 17:09:01.478772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 72cd7ab94678b6bc2e607702cc398a378a1787a8 --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 72cd7ab94678b6bc2e607702cc398a378a1787a8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-16 17:09:02,443 truncating revision to first 12 chars 2016-03-16 17:09:02,443 Setting DEBUG logging. 2016-03-16 17:09:02,443 attempt 1/10 2016-03-16 17:09:02,443 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/72cd7ab94678?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-16 17:09:03,572 unpacking tar archive at: fx-team-72cd7ab94678/testing/mozharness/ program finished with exit code 0 elapsedTime=1.366062 ========= master_lag: 5.71 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-03-16 17:09:08.552081) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:09:08.552377) ========= echo 72cd7ab94678b6bc2e607702cc398a378a1787a8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'72cd7ab94678b6bc2e607702cc398a378a1787a8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 72cd7ab94678b6bc2e607702cc398a378a1787a8 program finished with exit code 0 elapsedTime=0.005840 script_repo_revision: '72cd7ab94678b6bc2e607702cc398a378a1787a8' ========= master_lag: 0.47 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-16 17:09:09.028800) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-03-16 17:09:09.029090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 4 secs) (at 2016-03-16 17:09:13.577958) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-16 17:09:13.578219) ========= /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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:13 INFO - MultiFileLogger online at 20160316 17:09:13 in /builds/slave/test 17:09:13 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 17:09:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:09:13 INFO - {'append_to_log': False, 17:09:13 INFO - 'base_work_dir': '/builds/slave/test', 17:09:13 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:09:13 INFO - 'branch': 'Fx-Team', 17:09:13 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:13 INFO - 'config_files': ('talos/mac_config.py',), 17:09:13 INFO - 'default_actions': ('clobber', 17:09:13 INFO - 'read-buildbot-config', 17:09:13 INFO - 'download-and-extract', 17:09:13 INFO - 'populate-webroot', 17:09:13 INFO - 'create-virtualenv', 17:09:13 INFO - 'install', 17:09:13 INFO - 'run-tests'), 17:09:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:13 INFO - 'download_minidump_stackwalk': True, 17:09:13 INFO - 'download_symbols': 'ondemand', 17:09:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:13 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:13 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:13 INFO - 'installer_path': 'installer.exe', 17:09:13 INFO - 'log_level': 'info', 17:09:13 INFO - 'log_name': 'talos', 17:09:13 INFO - 'log_to_console': True, 17:09:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:09:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:09:13 INFO - 'opt_config_files': (), 17:09:13 INFO - 'pip_index': False, 17:09:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:13 INFO - 'cmd': ('bash', 17:09:13 INFO - '-c', 17:09:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:13 INFO - 'enabled': True, 17:09:13 INFO - 'halt_on_failure': False, 17:09:13 INFO - 'name': 'check_screen_resolution'},), 17:09:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:09:13 INFO - 'cmd': ('bash', 17:09:13 INFO - '-c', 17:09:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:09:13 INFO - 'enabled': True, 17:09:13 INFO - 'halt_on_failure': False, 17:09:13 INFO - 'name': 'check_screen_resolution'},), 17:09:13 INFO - 'run_cmd_checks_enabled': True, 17:09:13 INFO - 'sps_profile': False, 17:09:13 INFO - 'sps_profile_interval': 0, 17:09:13 INFO - 'suite': 'dromaeojs', 17:09:13 INFO - 'system_bits': '32', 17:09:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:13 INFO - 'title': 't-yosemite-r7-0057', 17:09:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:13 INFO - 'use_talos_json': True, 17:09:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:09:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:13 INFO - 'work_dir': 'build'} 17:09:13 INFO - ##### 17:09:13 INFO - ##### Running clobber step. 17:09:13 INFO - ##### 17:09:13 INFO - Running pre-action listener: _resource_record_pre_action 17:09:13 INFO - Running main action method: clobber 17:09:13 INFO - rmtree: /builds/slave/test/build 17:09:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:09:15 INFO - Running post-action listener: _resource_record_post_action 17:09:15 INFO - ##### 17:09:15 INFO - ##### Running read-buildbot-config step. 17:09:15 INFO - ##### 17:09:15 INFO - Running pre-action listener: _resource_record_pre_action 17:09:15 INFO - Running main action method: read_buildbot_config 17:09:15 INFO - Using buildbot properties: 17:09:15 INFO - { 17:09:15 INFO - "project": "", 17:09:15 INFO - "product": "firefox", 17:09:15 INFO - "script_repo_revision": "production", 17:09:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:09:15 INFO - "repository": "", 17:09:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:09:15 INFO - "buildid": "20160316085442", 17:09:15 INFO - "pgo_build": "False", 17:09:15 INFO - "basedir": "/builds/slave/test", 17:09:15 INFO - "buildnumber": 509, 17:09:15 INFO - "slavename": "t-yosemite-r7-0057", 17:09:15 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 17:09:15 INFO - "platform": "yosemite_r7", 17:09:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:09:15 INFO - "branch": "fx-team", 17:09:15 INFO - "repo_path": "integration/fx-team", 17:09:15 INFO - "revision": "72cd7ab94678b6bc2e607702cc398a378a1787a8", 17:09:15 INFO - "stage_platform": "macosx64", 17:09:15 INFO - "builduid": "ebfc4d8c48dc4412b2f85d76adab9f30", 17:09:15 INFO - "slavebuilddir": "test" 17:09:15 INFO - } 17:09:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:09:15 INFO - Running post-action listener: _resource_record_post_action 17:09:15 INFO - ##### 17:09:15 INFO - ##### Running download-and-extract step. 17:09:15 INFO - ##### 17:09:15 INFO - Running pre-action listener: _resource_record_pre_action 17:09:15 INFO - Running main action method: download_and_extract 17:09:15 INFO - mkdir: /builds/slave/test/build/tests 17:09: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')]} 17:09:15 INFO - https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:09:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:09:20 INFO - Downloaded 1199 bytes. 17:09:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:09:20 INFO - Using the following test package requirements: 17:09:20 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:09:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:09:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:09:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'jsshell-mac.zip'], 17:09:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:09:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:09:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:09:20 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:09:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:09:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:09:20 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:09:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:09: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')]} 17:09:20 INFO - https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:09:22 INFO - Downloaded 17854421 bytes. 17:09:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:09:25 INFO - Return code: 0 17:09:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:09:25 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')]} 17:09:25 INFO - https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:09:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:09:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:09:28 INFO - Downloaded 17854421 bytes. 17:09:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:09:31 INFO - Return code: 0 17:09:31 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')]} 17:09:31 INFO - https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:09:33 INFO - Downloaded 10846462 bytes. 17:09:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:09:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:09:33 INFO - Return code: 0 17:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:33 INFO - https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:09:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:09:37 INFO - Downloaded 111185666 bytes. 17:09:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:37 INFO - mkdir: /builds/slave/test/properties 17:09:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:09:37 INFO - Writing to file /builds/slave/test/properties/build_url 17:09:37 INFO - Contents: 17:09:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:09:38 INFO - Running post-action listener: _resource_record_post_action 17:09:38 INFO - Running post-action listener: set_extra_try_arguments 17:09:38 INFO - ##### 17:09:38 INFO - ##### Running populate-webroot step. 17:09:38 INFO - ##### 17:09:38 INFO - Running pre-action listener: _resource_record_pre_action 17:09:38 INFO - Running main action method: populate_webroot 17:09:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:38 INFO - '--tppagecycles', 17:09:38 INFO - '7'], 17:09:38 INFO - 'tests': ['tsvgm']}}, 17:09:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:09:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:09:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'tests': ['damp', 'tps']}, 17:09:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['damp', 'tps']}, 17:09:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:09:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:38 INFO - 'other': {'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'other_l64': {'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'other_nol64': {'tests': ['a11yr', 17:09:38 INFO - 'ts_paint', 17:09:38 INFO - 'tpaint', 17:09:38 INFO - 'sessionrestore', 17:09:38 INFO - 'sessionrestore_no_auto_restore', 17:09:38 INFO - 'tabpaint']}, 17:09:38 INFO - 'svgr': {'tests': ['tsvgx', 17:09:38 INFO - 'tsvgr_opacity', 17:09:38 INFO - 'tart', 17:09:38 INFO - 'tscrollx', 17:09:38 INFO - 'cart']}, 17:09:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['tsvgx', 17:09:38 INFO - 'tsvgr_opacity', 17:09:38 INFO - 'tart', 17:09:38 INFO - 'tscrollx', 17:09:38 INFO - 'cart']}, 17:09:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'tests': ['tp5o']}, 17:09:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'talos_options': ['--e10s'], 17:09:38 INFO - 'tests': ['tp5o']}, 17:09:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'talos_options': ['--xperf_path', 17:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:38 INFO - 'tests': ['tp5n']}, 17:09:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:38 INFO - 'talos_options': ['--e10s', 17:09:38 INFO - '--xperf_path', 17:09:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:38 INFO - 'tests': ['tp5n']}}, 17:09:38 INFO - 'talos.zip': {'path': '', 17:09:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:38 INFO - Running post-action listener: _resource_record_post_action 17:09:38 INFO - ##### 17:09:38 INFO - ##### Running create-virtualenv step. 17:09:38 INFO - ##### 17:09:38 INFO - Running pre-action listener: _resource_record_pre_action 17:09:38 INFO - Running main action method: create_virtualenv 17:09:38 INFO - Creating virtualenv /builds/slave/test/build/venv 17:09:38 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 17:09:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:09:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:38 INFO - Using real prefix '/tools/python27' 17:09:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:09:39 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:41 INFO - Installing pip.................done. 17:09:41 INFO - Return code: 0 17:09:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:41 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:41 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 17:09:41 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 17:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:41 INFO - 'HOME': '/Users/cltbld', 17:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:41 INFO - 'LOGNAME': 'cltbld', 17:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:41 INFO - 'MOZ_NO_REMOTE': '1', 17:09:41 INFO - 'NO_EM_RESTART': '1', 17:09:41 INFO - 'PAGER': '/bin/cat', 17:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:41 INFO - 'PWD': '/builds/slave/test', 17:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:41 INFO - 'SHELL': '/bin/bash', 17:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:41 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:41 INFO - 'USER': 'cltbld', 17:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:41 INFO - 'XPC_FLAGS': '0x0', 17:09:41 INFO - 'XPC_SERVICE_NAME': '0', 17:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:42 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 17:09:42 INFO - Cleaning up... 17:09:42 INFO - Return code: 0 17:09:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:42 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:42 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 17:09:42 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 17:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:42 INFO - 'HOME': '/Users/cltbld', 17:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:42 INFO - 'LOGNAME': 'cltbld', 17:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:42 INFO - 'MOZ_NO_REMOTE': '1', 17:09:42 INFO - 'NO_EM_RESTART': '1', 17:09:42 INFO - 'PAGER': '/bin/cat', 17:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:42 INFO - 'PWD': '/builds/slave/test', 17:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:42 INFO - 'SHELL': '/bin/bash', 17:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:42 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:42 INFO - 'USER': 'cltbld', 17:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:42 INFO - 'XPC_FLAGS': '0x0', 17:09:42 INFO - 'XPC_SERVICE_NAME': '0', 17:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:42 INFO - Downloading/unpacking psutil>=0.7.1 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:42 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 17:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:45 INFO - Installing collected packages: psutil 17:09:45 INFO - Running setup.py install for psutil 17:09:45 INFO - building 'psutil._psutil_osx' extension 17:09:45 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 17:09:46 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 17:09:46 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 17:09:46 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 17:09:46 INFO - building 'psutil._psutil_posix' extension 17:09:46 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 17:09:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:09:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:09:46 INFO - ^ 17:09:46 INFO - 1 warning generated. 17:09:46 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 17:09:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:46 INFO - Successfully installed psutil 17:09:46 INFO - Cleaning up... 17:09:46 INFO - Return code: 0 17:09:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:46 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:46 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 17:09:46 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 17:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:46 INFO - 'HOME': '/Users/cltbld', 17:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:46 INFO - 'LOGNAME': 'cltbld', 17:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:46 INFO - 'MOZ_NO_REMOTE': '1', 17:09:46 INFO - 'NO_EM_RESTART': '1', 17:09:46 INFO - 'PAGER': '/bin/cat', 17:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:46 INFO - 'PWD': '/builds/slave/test', 17:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:46 INFO - 'SHELL': '/bin/bash', 17:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:46 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:46 INFO - 'USER': 'cltbld', 17:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:46 INFO - 'XPC_FLAGS': '0x0', 17:09:46 INFO - 'XPC_SERVICE_NAME': '0', 17:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:49 INFO - Installing collected packages: mozsystemmonitor 17:09:49 INFO - Running setup.py install for mozsystemmonitor 17:09:49 INFO - Successfully installed mozsystemmonitor 17:09:49 INFO - Cleaning up... 17:09:49 INFO - Return code: 0 17:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:49 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 17:09:49 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 17:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:49 INFO - 'HOME': '/Users/cltbld', 17:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:49 INFO - 'LOGNAME': 'cltbld', 17:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:49 INFO - 'MOZ_NO_REMOTE': '1', 17:09:49 INFO - 'NO_EM_RESTART': '1', 17:09:49 INFO - 'PAGER': '/bin/cat', 17:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:49 INFO - 'PWD': '/builds/slave/test', 17:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:49 INFO - 'SHELL': '/bin/bash', 17:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:49 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:49 INFO - 'USER': 'cltbld', 17:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:49 INFO - 'XPC_FLAGS': '0x0', 17:09:49 INFO - 'XPC_SERVICE_NAME': '0', 17:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:50 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:52 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 17:09:52 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 17:09:52 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 17:09:52 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 17:09:52 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 17:09:52 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 17:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:53 INFO - Downloading docopt-0.6.1.tar.gz 17:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:53 INFO - Running setup.py install for blobuploader 17:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:53 INFO - Running setup.py install for requests 17:09:54 INFO - Running setup.py install for docopt 17:09:54 INFO - Successfully installed blobuploader requests docopt 17:09:54 INFO - Cleaning up... 17:09:54 INFO - Return code: 0 17:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:54 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:54 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 17:09:54 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 17:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:54 INFO - 'HOME': '/Users/cltbld', 17:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:54 INFO - 'LOGNAME': 'cltbld', 17:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:54 INFO - 'MOZ_NO_REMOTE': '1', 17:09:54 INFO - 'NO_EM_RESTART': '1', 17:09:54 INFO - 'PAGER': '/bin/cat', 17:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:54 INFO - 'PWD': '/builds/slave/test', 17:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:54 INFO - 'SHELL': '/bin/bash', 17:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:54 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:54 INFO - 'USER': 'cltbld', 17:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:54 INFO - 'XPC_FLAGS': '0x0', 17:09:54 INFO - 'XPC_SERVICE_NAME': '0', 17:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:54 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-CZ1efY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:54 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gydK7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MYxTJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-eXHnHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-A5ZQ2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-m4VS7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-haLxih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-eHyw6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-LtmZ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-4KrFMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-hevB8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:55 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-eWOrvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:56 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-9_IBFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:56 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-IVwSei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:56 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-o2mgVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:56 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-3mhUxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:56 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MsApjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:56 INFO - Running setup.py install for manifestparser 17:09:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:56 INFO - Running setup.py install for mozcrash 17:09:56 INFO - Running setup.py install for mozdebug 17:09:56 INFO - Running setup.py install for mozdevice 17:09:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Running setup.py install for mozfile 17:09:57 INFO - Running setup.py install for mozhttpd 17:09:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Running setup.py install for mozinfo 17:09:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Running setup.py install for mozInstall 17:09:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:57 INFO - Running setup.py install for mozleak 17:09:57 INFO - Running setup.py install for mozlog 17:09:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Running setup.py install for moznetwork 17:09:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Running setup.py install for mozprocess 17:09:58 INFO - Running setup.py install for mozprofile 17:09:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Running setup.py install for mozrunner 17:09:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:58 INFO - Running setup.py install for mozscreenshot 17:09:58 INFO - Running setup.py install for moztest 17:09:59 INFO - Running setup.py install for mozversion 17:09:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:59 INFO - Cleaning up... 17:09:59 INFO - Return code: 0 17:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:59 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:09:59 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 17:09:59 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 17:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:59 INFO - 'HOME': '/Users/cltbld', 17:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:59 INFO - 'LOGNAME': 'cltbld', 17:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:59 INFO - 'MOZ_NO_REMOTE': '1', 17:09:59 INFO - 'NO_EM_RESTART': '1', 17:09:59 INFO - 'PAGER': '/bin/cat', 17:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:59 INFO - 'PWD': '/builds/slave/test', 17:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:59 INFO - 'SHELL': '/bin/bash', 17:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:09:59 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:59 INFO - 'USER': 'cltbld', 17:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:59 INFO - 'XPC_FLAGS': '0x0', 17:09:59 INFO - 'XPC_SERVICE_NAME': '0', 17:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-aMaX9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:59 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)) 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-vZWTz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gUFfto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:59 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)) 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-p36utx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:59 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)) 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-xfNtjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:59 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)) 17:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:59 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-fr1qzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-_uWTSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-3fnYQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-F38FYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-KzNrHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-6OaBJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ASdPfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-D1PpVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-qDi6UY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:10:00 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)) 17:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:00 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-nVzcIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:10:01 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)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:10:01 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-EyWtTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:10:01 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)) 17:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:10:01 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gAWU31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:10:01 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)) 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:10:01 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)) 17:10:01 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)) 17:10:01 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)) 17:10:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:01 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 17:10:03 INFO - Downloading blessings-1.6.tar.gz 17:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:10:03 INFO - Installing collected packages: blessings 17:10:03 INFO - Running setup.py install for blessings 17:10:03 INFO - Successfully installed blessings 17:10:03 INFO - Cleaning up... 17:10:04 INFO - Return code: 0 17:10:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:04 INFO - Reading from file tmpfile_stdout 17:10:04 INFO - Current package versions: 17:10:04 INFO - blessings == 1.6 17:10:04 INFO - blobuploader == 1.2.4 17:10:04 INFO - docopt == 0.6.1 17:10:04 INFO - manifestparser == 1.1 17:10:04 INFO - mozInstall == 1.12 17:10:04 INFO - mozcrash == 0.17 17:10:04 INFO - mozdebug == 0.1 17:10:04 INFO - mozdevice == 0.48 17:10:04 INFO - mozfile == 1.2 17:10:04 INFO - mozhttpd == 0.7 17:10:04 INFO - mozinfo == 0.9 17:10:04 INFO - mozleak == 0.1 17:10:04 INFO - mozlog == 3.1 17:10:04 INFO - moznetwork == 0.27 17:10:04 INFO - mozprocess == 0.22 17:10:04 INFO - mozprofile == 0.28 17:10:04 INFO - mozrunner == 6.11 17:10:04 INFO - mozscreenshot == 0.1 17:10:04 INFO - mozsystemmonitor == 0.0 17:10:04 INFO - moztest == 0.7 17:10:04 INFO - mozversion == 1.4 17:10:04 INFO - psutil == 3.1.1 17:10:04 INFO - requests == 1.2.3 17:10:04 INFO - wsgiref == 0.1.2 17:10:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:04 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:10:04 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 17:10:04 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 17:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:04 INFO - 'HOME': '/Users/cltbld', 17:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:04 INFO - 'LOGNAME': 'cltbld', 17:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:04 INFO - 'MOZ_NO_REMOTE': '1', 17:10:04 INFO - 'NO_EM_RESTART': '1', 17:10:04 INFO - 'PAGER': '/bin/cat', 17:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:04 INFO - 'PWD': '/builds/slave/test', 17:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:04 INFO - 'SHELL': '/bin/bash', 17:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:10:04 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:04 INFO - 'USER': 'cltbld', 17:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:04 INFO - 'XPC_FLAGS': '0x0', 17:10:04 INFO - 'XPC_SERVICE_NAME': '0', 17:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 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)) 17:10:04 INFO - Cleaning up... 17:10:04 INFO - Return code: 0 17:10:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:10:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:04 INFO - 'HOME': '/Users/cltbld', 17:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:04 INFO - 'LOGNAME': 'cltbld', 17:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:04 INFO - 'MOZ_NO_REMOTE': '1', 17:10:04 INFO - 'NO_EM_RESTART': '1', 17:10:04 INFO - 'PAGER': '/bin/cat', 17:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:04 INFO - 'PWD': '/builds/slave/test', 17:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:04 INFO - 'SHELL': '/bin/bash', 17:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:10:04 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:04 INFO - 'USER': 'cltbld', 17:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:04 INFO - 'XPC_FLAGS': '0x0', 17:10:04 INFO - 'XPC_SERVICE_NAME': '0', 17:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:04 INFO - Downloading/unpacking jsonschema 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:07 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:07 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:07 INFO - warning: no files found matching '*.txt' 17:10:07 INFO - no previously-included directories found matching 'build' 17:10:07 INFO - no previously-included directories found matching 'dist' 17:10:07 INFO - no previously-included directories found matching '.git*' 17:10:07 INFO - Installing collected packages: jsonschema, functools32 17:10:07 INFO - Running setup.py install for functools32 17:10:07 INFO - warning: no files found matching '*.txt' 17:10:07 INFO - no previously-included directories found matching 'build' 17:10:07 INFO - no previously-included directories found matching 'dist' 17:10:07 INFO - no previously-included directories found matching '.git*' 17:10:07 INFO - Successfully installed jsonschema functools32 17:10:07 INFO - Cleaning up... 17:10:08 INFO - Return code: 0 17:10:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:08 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 0x10790aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa443d89cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, '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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 17:10:08 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 17:10:08 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 17:10:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:10:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:08 INFO - 'HOME': '/Users/cltbld', 17:10:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:08 INFO - 'LOGNAME': 'cltbld', 17:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:08 INFO - 'MOZ_NO_REMOTE': '1', 17:10:08 INFO - 'NO_EM_RESTART': '1', 17:10:08 INFO - 'PAGER': '/bin/cat', 17:10:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:08 INFO - 'PWD': '/builds/slave/test', 17:10:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:08 INFO - 'SHELL': '/bin/bash', 17:10:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:10:08 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:10:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:08 INFO - 'USER': 'cltbld', 17:10:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:08 INFO - 'XPC_FLAGS': '0x0', 17:10:08 INFO - 'XPC_SERVICE_NAME': '0', 17:10:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:08 INFO - Downloading/unpacking flake8 17:10: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 17:10: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 17:10: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 17:10:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10: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 17:10: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 17:10:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:10 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 17:10:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 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 17:10:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:12 INFO - no previously-included directories found matching 'docs/_build' 17:10:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:12 INFO - Running setup.py install for pep8 17:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:12 INFO - no previously-included directories found matching 'docs/_build' 17:10:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:10:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:12 INFO - Cleaning up... 17:10:12 INFO - Return code: 0 17:10:12 INFO - Running post-action listener: _resource_record_post_action 17:10:12 INFO - Running post-action listener: _start_resource_monitoring 17:10:12 INFO - Starting resource monitoring. 17:10:12 INFO - ##### 17:10:12 INFO - ##### Running install step. 17:10:12 INFO - ##### 17:10:12 INFO - Running pre-action listener: _resource_record_pre_action 17:10:12 INFO - Running main action method: install 17:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:10:12 INFO - Reading from file tmpfile_stdout 17:10:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:10:12 INFO - Reading from file tmpfile_stdout 17:10:12 INFO - Output received: 17:10:12 INFO - Usage: mozinstall [options] installer 17:10:12 INFO - Options: 17:10:12 INFO - -h, --help show this help message and exit 17:10:12 INFO - -d DEST, --destination=DEST 17:10:12 INFO - Directory to install application into. [default: 17:10:12 INFO - "/builds/slave/test"] 17:10:12 INFO - --app=APP Application being installed. [default: firefox] 17:10:12 INFO - mkdir: /builds/slave/test/build/application 17:10:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:10:47 INFO - Reading from file tmpfile_stdout 17:10:47 INFO - Output received: 17:10:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:10:47 INFO - Running post-action listener: _resource_record_post_action 17:10:47 INFO - ##### 17:10:47 INFO - ##### Running run-tests step. 17:10:47 INFO - ##### 17:10:47 INFO - Running pre-action listener: _resource_record_pre_action 17:10:47 INFO - Running main action method: run_tests 17:10:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:10:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:10:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:10:47 INFO - 2016-03-16 17:10:47.187 screenresolution[1648:7915] starting screenresolution argv=screenresolution get 17:10:47 INFO - 2016-03-16 17:10:47.190 screenresolution[1648:7915] Display 0: 1600x1200x32@60 17:10:47 INFO - 2016-03-16 17:10:47.195 screenresolution[1649:7917] starting screenresolution argv=screenresolution list 17:10:47 INFO - Available Modes on Display 0 17:10:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:10:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:10:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:10:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:10:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:10:47 INFO - Intel Iris: 17:10:47 INFO - Chipset Model: Intel Iris 17:10:47 INFO - Type: GPU 17:10:47 INFO - Bus: Built-In 17:10:47 INFO - VRAM (Dynamic, Max): 1536 MB 17:10:47 INFO - Vendor: Intel (0x8086) 17:10:47 INFO - Device ID: 0x0a2e 17:10:47 INFO - Revision ID: 0x0009 17:10:47 INFO - Displays: 17:10:47 INFO - Display: 17:10:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:10:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:10:47 INFO - Display Serial Number: 1600x1200 60 17:10:47 INFO - Main Display: Yes 17:10:47 INFO - Mirror: Off 17:10:47 INFO - Online: Yes 17:10:47 INFO - Rotation: Supported 17:10:47 INFO - Return code: 0 17:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:10:47 INFO - Python 2.7.3 17:10:47 INFO - Return code: 0 17:10:47 INFO - grabbing minidump binary from tooltool 17:10:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:47 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 0x1077aed30>, '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 0x1075d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:10:47 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 17:10:47 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 17:10:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:47 INFO - Return code: 0 17:10:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:10:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:10:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:10:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:10:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:10:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:10:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:10:48 INFO - Return code: 0 17:10:48 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/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 17:10:48 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/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --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 17:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m4CJmNrBDf/Render', 17:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:10:48 INFO - 'HOME': '/Users/cltbld', 17:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:10:48 INFO - 'LOGNAME': 'cltbld', 17:10:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:10:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:48 INFO - 'MOZ_NO_REMOTE': '1', 17:10:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:10:48 INFO - 'NO_EM_RESTART': '1', 17:10:48 INFO - 'PAGER': '/bin/cat', 17:10:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:10:48 INFO - 'PWD': '/builds/slave/test', 17:10:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:10:48 INFO - 'SHELL': '/bin/bash', 17:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Lwt4yFW5GJ/Listeners', 17:10:48 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 17:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:10:48 INFO - 'USER': 'cltbld', 17:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:48 INFO - 'XPC_FLAGS': '0x0', 17:10:48 INFO - 'XPC_SERVICE_NAME': '0', 17:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:10:48 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/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 17:10:48 INFO - mozversion application_buildid: 20160316085442 17:10:48 INFO - mozversion application_changeset: 72cd7ab94678b6bc2e607702cc398a378a1787a8 17:10:48 INFO - mozversion application_display_name: Nightly 17:10:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:48 INFO - mozversion application_name: Firefox 17:10:48 INFO - mozversion application_remotingname: firefox 17:10:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:48 INFO - mozversion application_vendor: Mozilla 17:10:48 INFO - mozversion application_version: 48.0a1 17:10:48 INFO - mozversion platform_buildid: 20160316085442 17:10:48 INFO - mozversion platform_changeset: 72cd7ab94678b6bc2e607702cc398a378a1787a8 17:10:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:48 INFO - mozversion platform_version: 48.0a1 17:10:48 INFO - using testdate: 1458173448 17:10:48 INFO - actual date: 1458173448 17:10:48 INFO - starting webserver on 'localhost:49270' 17:10:48 INFO - SUITE-START | Running 2 tests 17:10:48 INFO - TEST-START | dromaeo_css 17:10:48 INFO - operating with platform_type : mac_ 17:10:48 INFO - Initialising browser for dromaeo_css test... 17:10:48 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpZZBqAT/profile http://localhost:49270/getInfo.html) 17:10:51 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 17:10:51 INFO - PROCESS | 1667 | colorDepth:24 17:10:51 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 17:10:51 INFO - PROCESS | 1667 | __metrics 17:10:51 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:10:51 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:10:52 INFO - TEST-INFO | 1667: exit 0 17:10:52 INFO - Browser initialized. 17:10:52 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:52 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpZZBqAT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:11:04 INFO - PROCESS | 1671 | RSS: Main: 242864128 17:11:04 INFO - PROCESS | 1671 | 17:11:55 INFO - PROCESS | 1671 | 1458173515160 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] 17:14:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:14:07 INFO - PROCESS | 1671 | RSS: Main: 465035264 17:14:07 INFO - PROCESS | 1671 | 17:17:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:17:10 INFO - PROCESS | 1671 | RSS: Main: 382386176 17:17:10 INFO - PROCESS | 1671 | 17:20:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:20:13 INFO - PROCESS | 1671 | RSS: Main: 374603776 17:20:13 INFO - PROCESS | 1671 | 17:23:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:23:16 INFO - PROCESS | 1671 | RSS: Main: 335351808 17:23:16 INFO - PROCESS | 1671 | 17:26:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:26:19 INFO - PROCESS | 1671 | RSS: Main: 335208448 17:26:19 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:29:22 INFO - PROCESS | 1671 | RSS: Main: 380780544 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | __start_tp_report 17:29:22 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 17:29:22 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 17:29:22 INFO - PROCESS | 1671 | |i|pagename|runs| 17:29:22 INFO - PROCESS | 1671 | |0;dojo.html;3404.3872103021454;3473.982630086849;3474.305138972203;3489.180042689967;3537.929241415172;5556.499915007648;5597.748101335439;5620.606557540974;5637.718114094294;5676.262085928829;5599.776008959647;5617.466340697627;5656.688882111493;5748.5975981681295;5809.244798176232;5056.519630635084;5111.182210846266;5126.538611524962;5144.845654630367;5201.921971170435;5157.2006339017325;5178.482151784829;5210.062188806013;5230.215467679859;5277.076511610472;5035.874103147451;5046.394432668085;5129.563987061104;5147.922781158286;5151.871203219931;5184.870378240536;5190.948090519122;5194.013137503862;5203.401608814959;5220.164773636238;5103.464136265713;5120.231965205249;5143.3570803649545;5149.588032957355;5183.870403239912;5461.69960652164;5570.053090974544;5572.331320241597;5590.385057643656;5591.440855914417;6046.645266119765;6058.946529921364;6077.0276755719315;6092.846225312422;6095.86063177464;6022.578419510636;6034;6193.84515387119;6243.812685619393;6264.27960784511;5687.60186786921;5715.5427565794635;5721.370649228582;5740.7703691852275;5799.014167591477;5166.328377311001;6155.10750941111;6191.19514463126;6205.565610407319;6222.844428889314;6088.756449742049;6091.482224011009;6098.635072127691;6101.023836186189;6123.418275263932;6059.818205453844;6202.472789812917;6220.906686399708;6229.314775374705;6236.812895613139;5973.940260597426;6092.695365231721;6100.359462256488;6110.541709371815;6142.754289828356;4618.67669263155;6155.599886007395;6166.167567378347;6191.226096737908;6201.162843016135;4861.246506791453;4867.464578896319;4876.756162191876;4885.780139893643;4914.877128071756;3670.6696397324367;4269.615734583902;4329.935050974238;4365.236083685342;4394.2749446340995;5592.245046918695;5595.496405323541;5622.212890195376;5713.657180569179;5717.771289148471;6121.357257487989;6177.722002509898;6185.536084793658;6194.287656919512;6198.411150940653;5545.085060964976;5568.053430916673;5615.494605485526;5622.269105016404;5639.069553523705;5271;5297.735113244323;5325.227841962894;5363.544098751572;5375.408705042442;6192.5974811638;6200.596961197418;6210.223722034746;6222.502199824094;6222.782202622887;6069.605475644069;6165.938340616716;6181.505479561534;6189.845253868509;6208.906866396917;5288.762005709676;6193.256809182927;6242.375762423721;6262.060690896402;6284.905726414016;6061.727222275096;6091.908621370594;6103.6032657877095;6115.541334400027;6117.296510901126;5863.794767183128;6158.692065396802;6171.321154672893;6200.937990620036;6202.2867370253;5919.260092488439;5958;5962.344142144448;5971.701414929149;5974.133750606051;5959.73181206838;5960.701964901651;5963.135345374983;5978.760849565969;5982.880342393215;5807.680577568274;5825.038868586806;5826.213461182856;5826.41735826414;5831.1836342912875;5128.6153538485505;5922.555808314308;5924.555658325557;5942.494887934401;6065.090236464565;5877.764889404376;5892.234009578728;5894.174815525916;5936.910946335722;5939.584229103922 17:29:22 INFO - PROCESS | 1671 | |1;ext.html;456.9581354511715;585.9803941142411;600.7236671131279;640.7693230437042;653.428250281004;36675.81662091689;37347.87956361307;37423.812880935555;37542;37554.248915021686;37677.623223767754;38349.61650383495;38358.04104897372;38388.42417363742;38403.615963840355;9340.065993400674;9555.235581153525;9567.52162391881;9580.473073980927;9588.952055239713;9492.952535237315;9674.806503869919;9678.177354924805;9689.176420004309;9692.418454892693;9636.518174091303;9718.396464583335;9728.951355243249;9732.07545283197;9733.2213422926;9622.470764107971;9706.660266890625;9710.417374957526;9710.514474276259;9714.562844672007;9548.809023819485;9689.224862011022;9690.46702431366;9702.029797020312;9703.854442183372;37326.626733732584;38079.23841523154;38581.80709096465;38601.61398386008;38671;3256.9837150814333;3266.3304022675293;3373.7975721456546;3374.510695949098;3485.4597537381746;29037;29280.68236929322;29342.853285733647;29689.851550742325;29779.957701480344;2686.0867305116158;2714.09077958884;2725.250556097089;2846.5303224967856;2893.7250961158866;461000;463863;463998;465029.674851627;465982;52903.470965290624;59954.80090398255;60301.69849150814;60659.69670151621;60785;51241.487585124414;64389;65657.67171164209;65767;65998.67000664966;16062;16253.59366015859;16268.430604928772;16273.349066037226;16285.755713664304;11468.426578671033;12473.937630311972;12522.686932826753;12566.497340106476;12795.296258705861;18753.90623046876;18769.155388007573;18818;18826.341078062476;18841.905790471235;7496.662650180755;7774.105977812624;8797.252233560092;8902.599383027778;9001.909980900107;938.9671361502315;954.6467806911487;1014.1633152648947;1016.4815943868532;1134.3420815926743;28947.710522894922;29381.706182938324;29570.408591828043;29634;31532.52701209438;991.4299277915228;1147.4148184426003;1167.3404526442532;1188.619641714643;1213.168979249217;14829.18439485817;14854.925725371304;15108.924455377653;15156;15219.086854788748;510085;511015;516869;517243;518334;57901.71049144812;58377.416225837194;58471.70764146152;58583;58696;1272;1452.1142103316968;1497.7229212595705;1499.0406140070363;1559.7660350947222;24756.38109047288;28064.719352807027;28160.014399495918;28420.85789571039;28825.711742882304;45740.31389529226;46270.305945410175;46575.53424465848;46676.53323466722;46686.83282917954;348267;351300;351582;351771;352077;22680.979355929354;32133.678663214003;33091.83454082714;33105;33121.33757324888;40877.79561102176;42290.57709422866;42302.36546451867;42622;43563.34654980114;28675;36142.63857361393;36301.45547816838;36929;37015.81492092522;35373.115672108404;35551.644483555865;36016.27967440689;36109.458358124124;36184;35004.299914002084;35214.94355169349;35874.923752287476;36063.63936360603;36191;22863.657045144668;30829.69170308358;31194.797534726855;31564.053078407684;31732.206694832814;20346.89826550917;22001.779982199972;23894.751568933294;24167.39581510406;24408.779561022235 17:29:22 INFO - PROCESS | 1671 | |2;jquery.html;354.35861091424516;354.5019247956621;355.3248827228266;365.1000284299202;366.0427980830128;15734.370625174994;19130;19841;19841;19937.700934485994;18943.33698320559;19192.32826851057;19893.801061989376;19951.600967980667;19980.500487487785;5859.589828711981;6004.759809607611;6076.848078798022;6085.995810691231;6087.086936959469;4205.936910946339;4485.506594274627;6001.21984142061;6339.080833279172;6635;6563.901541476882;6575.967120164392;6579.703913323888;6583.80248592543;6584.2098948126295;6400.071989561511;6445.097686323918;6538.1827271591055;6572.375624315682;6579.868402631921;3734.4211647194456;5391.3799913009725;5604.85987850307;5616.410276920906;5664.773409063632;22132;22955.196568120034;22958.19646312371;24475.26574202777;24749.010039598394;2224.5773303072365;2281.2243837095466;2447.816413768957;2503.9358272734016;2563.3591602099477;9296.39573427725;9372.484513351763;9676.95161524195;9689.51552422383;9720.465374404404;1717.8883372580742;1726.6287748134212;1727.2745446912327;1778.0309731196528;1817.5546990987293;98661.50669246679;99029.50485247599;100058.49970750173;100433.99566004393;101994;10667.19996000303;10848.78302433947;10914.072303854262;10917.945410272898;10982.395968221665;13080.803787943189;13163;13170.341482925814;13178.472861085449;13190.60428187156;8184.713535026245;8367.246947774607;8374.985005398052;8449.704260350858;8459.873101903477;6626.7017984190825;8524.190201930807;8527;8528.658853645784;8643.524606146722;3633.3459977204357;3659.780413175218;3747.063234191452;4267.125239325931;4331.328644060176;1709.384621536246;1797.343969451141;1802.9356386936884;1807.8282563156479;1812.7099664053687;786.811165320319;805.9113497515268;968.5593055160026;1014.7209517382779;1016.3495362967707;16821.663566728843;16968.57578560546;18962.62074758497;19261.614767704566;19285.807141928683;942.7548837302351;990.6631745206664;997.960081596728;1045.137761346892;1082.1396989393452;10443.582256709798;10651.30766500175;10661.360318380766;10662.200334974908;10798.352098874093;558880;565918;581515;582002;583364;71523;85527;118956;122039.77960220462;122843.38578307051;1012.9949350253202;1051.0540513537724;1069.3209811769427;1071.1751950997843;1072.5012869015945;17227.3970411035;17549.824501754818;18109.909450452662;18110.094495275447;18246.270149193882;47113.52886471091;47653.523464764905;48050.519494804605;48183;48658.56707164698;68021.65989170023;68615;73862.26137738554;77114.22885771295;79697.8045329309;7408.888866666896;7437.066362745617;7460.216677249028;7548.4716069874585;7747.573883436465;10330.380177189392;10698.786024279316;12047.939760301142;12088.730683278129;12310.446029928495;7409.851802964018;8364.87452688198;10478.63324783629;10839.458027098455;10846.45767711627;10296.845547316947;10303.587856485656;10518.789624207626;10644.148468122377;10776.892231077589;10726.249162558546;10742.677719668422;10886.965738254854;10921.617743379262;11004.119670426187;7284.817879553054;7338.77983660491;7371.852562948604;7382.187959324578;7607.923920760722;8443.95778021106;10719.785604287714;10814.945925270324;11026.558937642405;11032.944835275772 17:29:22 INFO - PROCESS | 1671 | |3;mootools.html;1455.3160014793043;1591.403223791078;1623.2451909861911;1911.696405830973;2045.7033730109126;7813.335866451352;8442.957785211072;8567.485950842954;8575.01387340456;8586.184312490312;7217.675204615792;7697.153313135551;8147.9407677002055;8276.668933242678;8562.871556926651;2134.9146034158694;2376.1683410806168;2429.6112621980487;2433.926982190528;2466.001269485861;2394.1859767678984;2430.963535546968;2431.8540887546715;2433.5862903306393;2434.573949558829;2390.067873529325;2397.652340410639;2448.4123810285582;2458.3731148557094;2460.1020627470934;2403.627437747152;2435.9756402436014;2447.9143229986953;2454.6563481112657;2459.3359792855827;2408.1812183857573;2445.437549363656;2447.473793134485;2454.901803927841;2458.43456005118;8504.02203746571;8593.570321483963;8595.44129631572;8600.827983440358;8610.612522436506;5092.337996060525;5172.870678233075;5201.1678131498775;5208.947910520884;5220.947790522084;3428.63999280077;3537.7700449470703;3582.960941327012;3602.0814692253307;3609.5848977367677;1044.764927891226;1059.9576016959313;1067.2635881241995;1075.8493810866485;1078.7087486378712;11287.717807054807;11498.42507874603;11526.711832204179;11536.942315288454;11553.884461155365;4758;4777.4267087949665;4793.32893394925;4823.710577365299;4848.587870031016;10158.98410158993;10162.745931351776;10165.949170254102;10168.644097456554;10177.440240786827;5378.058839703036;5412.91880621791;5419.6477228980775;5428.430014848463;5433.940381625545;4259.74441533509;4410.4927933287445;4680.9297860532115;4789.994101238709;4797.088553174885;3882.3400021996326;3939.625735555118;3957.248122856648;3997.120633460634;3999.7800120993043;1119.6081371519904;1282.4293189530756;1296.695276609996;1322.272749987503;1322.6759443936296;1357.382391012087;1380.4133243371527;1407.56365526685;1412.6962703018694;1414.5402744108;7867.055953285528;8014.398920080901;8021;8026.357891368676;8035.196480351918;475.89768199837204;476.3022172517279;486.48432661379053;487.19369443570946;493.3758795124099;6121;6192.5974811638;6207.782727604512;6207.782727604603;6209.2548894133;10065.295429319878;10328.173746100294;10455.477226138815;10455.634052808115;10461.84919658837;9979.900200998043;10202.081812636898;10216.233782466195;10244.641437549799;10330.741731456774;8014.879776803353;8104.756857294173;8115.188481151838;8143.389245806469;8202.38482113844;7526.569951709158;7587.203343649058;7882.842343153219;7972.162922893012;8001.799955001172;8167.673293068211;9014.909850901407;9352;9376.343655944018;9425.434473931311;9388.859167112361;9529.809403811747;9711.3202075854;9729.416235025921;9750.268729845147;6596.076549283008;6787.5588086774205;7040.823979400556;7368.336849683555;7491.550506969599;7960.761177164694;8016.879746803919;8030.718924837603;8032.437729358889;8041.396895232764;7104.822379440556;7208.603526805866;7233.63831808418;7324.450666199949;7392.22381649919;6703.832404189934;7091.078159839188;7155.785326440215;7160.892586611101;7215.747448839265;7396.0754905636795;7530.9246907532415;7572.7728168155045;7640.121386040676;7642.8089297768;6881.13985751781;6886.070380498569;6931.930680693128;6935.687894044881;6947.131608548932;6691.397844093741;6957.721691132298;6960.095187625576;6974.442044636316;7011.544249623758 17:29:22 INFO - PROCESS | 1671 | |4;prototype.html;312.17429897920005;315.8247172819086;321.92273854274964;322.17683817845403;328.50067896796884;6630.270670226278;6676.566023208488;6746.077367950135;6747.39273465388;6781.627010514432;6622.701978410971;6643.202815662115;6656.567323123993;6661.400473957343;6666.799996000128;4704.341392205086;4754.786034628432;4782.593479554224;4878.682885612441;4929.556339929406;4826.638002149835;4879.121758083544;4882.462929077817;4891.682040667363;4893.975530122362;4667.76661166942;4809.927851082237;4814.590759785422;4821.662483626147;4825.469198388175;3929.3123703352085;4726.456457507396;4853.3690620219495;4869.099216644914;4897.8775530611665;4138.02756352257;4146.896327591804;4163.500379954395;4167.249895018896;4168.43726096976;6360.650164240965;6419.35806419359;6421.711023003976;6427.8393040173905;6439.259485159219;5730.226419433365;5737.942620573825;5740.655560666373;5743.396943320933;5756.82729518111;6695.096162018162;7034.366906978396;7053.68258428372;7061.858762824715;7073.752418665322;4465.709728867646;4491.6182124519455;4499.482559505666;4533.77331133442;4538.636909047268;7283;7346.4122870170795;7349.853002939964;7353.632318384113;7359.411247100219;4498.190325741398;4527.977360113245;4528.117017181684;4532.637389008937;4532.7280363178315;4578.725276483422;4594.150082234797;4599.563041511051;4601.987562736193;4602.217623004098;5464.972675136599;5467.343918729778;5469.398366179717;5470.042742520043;5484.177373393943;5745.913811292834;5747.942520574825;6376.29860715321;7081.150261968597;7109.502334836615;1582.2800625715272;1620.8491970700934;1621.1488968291505;1622.1970124788306;1623.091069001363;966.4201479112477;995.2137811129271;1021.2391768132641;1024.4775164665925;1040.953157107932;6608.2400523939405;6677.165354330708;6691.631960242234;6692.765753198614;6697.09589205451;6120.714649923566;7272.672729727175;7347.88978165328;7373.33639972405;7377.9262207378315;6663.06717059612;6672.165979252593;6676.132102826698;6676.933230667728;6684.364985326386;3747;3845.692344612424;3883.5533913599734;3892.630200130983;3899.454076429302;6144.600600960924;7693.769186924401;7694.153643099255;7700.229977002255;7706.152323244439;7482.625868706543;7528.284812942762;7536.886946695804;7537.057867766529;7552.962235188898;7641.808954776175;7659.770206893802;7663.42899705559;7672.80817979555;7673.309402153833;7048.541844780073;7296.1974182838785;7331.2302208267365;7340.339369456775;7345.70617175307;7133.892991605234;7172.426205903619;7181;7193.460490463341;7219.783406497603;7612;7622.885656715042;7628;7631.3131818136635;7655.923440765521;4590.793414296431;4595.885102872455;4601.194790911644;4608.5161058088415;4611.6310695144975;7057.541259818096;7262.745803896838;7267.273272672691;7272.127344718668;7294.562326260229;6981.720731170696;7030.789076327718;7039.753608623673;7041.260667629826;7048.365647091581;7010.75462358815;7012.5624247030255;7017.719291228498;7026.227115017242;7033.678885967721;5254.763535640829;5584.910942366199;6342.048692696132;6514.250861151028;6858.828529286808;6932.861342773015;7009.0537777399395;7030.61331626745;7046.964765176142;7088.574685518885;6676.89984650221;6719.899201511884;6826.249112597511;6834.282400347892;6926.307369263033 17:29:22 INFO - PROCESS | 1671 | |5;yui.html;693.6254422611789;745.4707157917878;757.9772606821797;766.5285849202738;774.8760198368255;14697.632559186026;14711.48509802157;14789.556313310617;14894;14897.702045959088;13921.651958701012;13975.860241397582;14038.438462461514;14045.50840720575;14062;730.3536370312286;737.2516895351223;738.9076365454318;899.1682693508511;921.7465197070792;737.3695490355749;887.0774394629577;923.2429407885503;925.5002298758662;925.7037747920668;958.0850287974968;962.956666949989;966.8694726211942;967.7290358699576;969.3844408800427;758.0978635423883;960.7694153403133;962.5427921737154;962.7978124593843;964.768455570665;693.2062788107588;713.9750108746169;716.369594756616;717.8779607466744;720.0387482710588;14598.270086495633;14655;14700.485483008044;14707.705845883129;14736.631584210481;12425.254484730855;12597.559085432058;12730.554430594884;12745.87254127456;12805.231686098863;9989;10041.246906482043;10069.194464442828;10110.24173187014;10377.273590848643;3482.94775578364;3518.5249991251367;3555.7333200010103;3558.3772839753196;3637.7453578249533;81989.59005204936;83782;84052;84182.57908710478;84213;9486.525673716287;9588.808223835484;9600.615975361046;9823.705288841345;10187.337823041478;20576.27983020617;22540.985655645534;22568.66147007796;22603.208887688852;22604.660930086062;7275.636218189175;7318.634068296564;7323.363589107917;7351.301626345488;7368.263173682696;3954.3870700040966;3984.86052988144;3992.920141597152;4003.559608443069;4058.2086493133556;3585.982070089633;3629.637036296402;3633.5276414066;3634.909127271839;3641.380965235863;658.9439897608661;667.8497338098889;668.6122049211446;684.5618803965466;685.3797313431353;573.7963023126813;576.7952376906222;584.6813486649786;609.6739591388712;628.6573817269508;8243.381746368927;8290.668373265122;8370.372222083368;8393.076761556224;8465.992035512469;481.7639356715184;499.03187815637546;571.7198572699348;578.8871170121786;595.2618752746649;2826.7879909006906;3765.9246815063543;3798.4682144499793;3829.751066180689;3969.861054863066;69748.6512567434;87972;90051;90351;91036;79207;79628.6018569915;80157;81267.5936620325;81484.59257703793;71409.92885106728;71771.92342114769;71833.64083179655;72571;73279.63360183165;7546.626555666519;7551.509151905108;7784.143744188248;7803.102643196105;8014.799630009296;46897.29654055124;47506.76246618745;47564.2865357013;47769.28346074742;47872.521274786806;63745.68127159335;67705;68221.63556728937;68661;68944.6552767233;9649.710508684751;9972.40165590038;9975.102240798364;10055.899441005497;10658.253922225369;10775.273478427132;10800.675979720621;10809.621663242064;10883.727906802393;11235;10216.591336346462;10220.080192782685;10290.176785856964;10514.526846292089;10654.57381704723;10387.272890897564;10394.22043346737;10547.630832920811;10667.679969600924;10782.299150555189;10184.287099902936;10202.59189632436;10478.528466219192;10591.417472039111;10600.840987385041;7970.322522585645;8830.02869684347;8878.289736820909;9029.77425564366;9123.498207598646;8815.779605509913;8820.382573219813;8884.73345799627;8928;9006.234470069856 17:29:22 INFO - PROCESS | 1671 | __end_tp_report 17:29:22 INFO - PROCESS | 1671 | __start_cc_report 17:29:22 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2249 17:29:22 INFO - PROCESS | 1671 | __end_cc_report 17:29:22 INFO - PROCESS | 1671 | __startTimestamp1458174562856__endTimestamp 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | ------- Summary: start ------- 17:29:22 INFO - PROCESS | 1671 | Number of tests: 6 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5643.63 Median:5826.42 stddev:623.35 (10.7%) stddev-sans-first:600.00 17:29:22 INFO - PROCESS | 1671 | Values: 3404.4 3474.0 3474.3 3489.2 3537.9 5556.5 5597.7 5620.6 5637.7 5676.3 5599.8 5617.5 5656.7 5748.6 5809.2 5056.5 5111.2 5126.5 5144.8 5201.9 5157.2 5178.5 5210.1 5230.2 5277.1 5035.9 5046.4 5129.6 5147.9 5151.9 5184.9 5190.9 5194.0 5203.4 5220.2 5103.5 5120.2 5143.4 5149.6 5183.9 5461.7 5570.1 5572.3 5590.4 5591.4 6046.6 6058.9 6077.0 6092.8 6095.9 6022.6 6034.0 6193.8 6243.8 6264.3 5687.6 5715.5 5721.4 5740.8 5799.0 5166.3 6155.1 6191.2 6205.6 6222.8 6088.8 6091.5 6098.6 6101.0 6123.4 6059.8 6202.5 6220.9 6229.3 6236.8 5973.9 6092.7 6100.4 6110.5 6142.8 4618.7 6155.6 6166.2 6191.2 6201.2 4861.2 4867.5 4876.8 4885.8 4914.9 3670.7 4269.6 4329.9 4365.2 4394.3 5592.2 5595.5 5622.2 5713.7 5717.8 6121.4 6177.7 6185.5 6194.3 6198.4 5545.1 5568.1 5615.5 5622.3 5639.1 5271.0 5297.7 5325.2 5363.5 5375.4 6192.6 6200.6 6210.2 6222.5 6222.8 6069.6 6165.9 6181.5 6189.8 6208.9 5288.8 6193.3 6242.4 6262.1 6284.9 6061.7 6091.9 6103.6 6115.5 6117.3 5863.8 6158.7 6171.3 6200.9 6202.3 5919.3 5958.0 5962.3 5971.7 5974.1 5959.7 5960.7 5963.1 5978.8 5982.9 5807.7 5825.0 5826.2 5826.4 5831.2 5128.6 5922.6 5924.6 5942.5 6065.1 5877.8 5892.2 5894.2 5936.9 5939.6 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:58843.53 Median:36802.41 stddev:119136.65 (323.7%) stddev-sans-first:119390.20 17:29:22 INFO - PROCESS | 1671 | Values: 457.0 586.0 600.7 640.8 653.4 36675.8 37347.9 37423.8 37542.0 37554.2 37677.6 38349.6 38358.0 38388.4 38403.6 9340.1 9555.2 9567.5 9580.5 9589.0 9493.0 9674.8 9678.2 9689.2 9692.4 9636.5 9718.4 9729.0 9732.1 9733.2 9622.5 9706.7 9710.4 9710.5 9714.6 9548.8 9689.2 9690.5 9702.0 9703.9 37326.6 38079.2 38581.8 38601.6 38671.0 3257.0 3266.3 3373.8 3374.5 3485.5 29037.0 29280.7 29342.9 29689.9 29780.0 2686.1 2714.1 2725.3 2846.5 2893.7 461000.0 463863.0 463998.0 465029.7 465982.0 52903.5 59954.8 60301.7 60659.7 60785.0 51241.5 64389.0 65657.7 65767.0 65998.7 16062.0 16253.6 16268.4 16273.3 16285.8 11468.4 12473.9 12522.7 12566.5 12795.3 18753.9 18769.2 18818.0 18826.3 18841.9 7496.7 7774.1 8797.3 8902.6 9001.9 939.0 954.6 1014.2 1016.5 1134.3 28947.7 29381.7 29570.4 29634.0 31532.5 991.4 1147.4 1167.3 1188.6 1213.2 14829.2 14854.9 15108.9 15156.0 15219.1 510085.0 511015.0 516869.0 517243.0 518334.0 57901.7 58377.4 58471.7 58583.0 58696.0 1272.0 1452.1 1497.7 1499.0 1559.8 24756.4 28064.7 28160.0 28420.9 28825.7 45740.3 46270.3 46575.5 46676.5 46686.8 348267.0 351300.0 351582.0 351771.0 352077.0 22681.0 32133.7 33091.8 33105.0 33121.3 40877.8 42290.6 42302.4 42622.0 43563.3 28675.0 36142.6 36301.5 36929.0 37015.8 35373.1 35551.6 36016.3 36109.5 36184.0 35004.3 35214.9 35874.9 36063.6 36191.0 22863.7 30829.7 31194.8 31564.1 31732.2 20346.9 22001.8 23894.8 24167.4 24408.8 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:32488.38 Median:2533.65 stddev:95201.93 (3757.5%) stddev-sans-first:95438.42 17:29:22 INFO - PROCESS | 1671 | Values: 354.4 354.5 355.3 365.1 366.0 15734.4 19130.0 19841.0 19841.0 19937.7 18943.3 19192.3 19893.8 19951.6 19980.5 5859.6 6004.8 6076.8 6086.0 6087.1 4205.9 4485.5 6001.2 6339.1 6635.0 6563.9 6576.0 6579.7 6583.8 6584.2 6400.1 6445.1 6538.2 6572.4 6579.9 3734.4 5391.4 5604.9 5616.4 5664.8 22132.0 22955.2 22958.2 24475.3 24749.0 2224.6 2281.2 2447.8 2503.9 2563.4 9296.4 9372.5 9677.0 9689.5 9720.5 1717.9 1726.6 1727.3 1778.0 1817.6 98661.5 99029.5 100058.5 100434.0 101994.0 10667.2 10848.8 10914.1 10917.9 10982.4 13080.8 13163.0 13170.3 13178.5 13190.6 8184.7 8367.2 8375.0 8449.7 8459.9 6626.7 8524.2 8527.0 8528.7 8643.5 3633.3 3659.8 3747.1 4267.1 4331.3 1709.4 1797.3 1802.9 1807.8 1812.7 786.8 805.9 968.6 1014.7 1016.3 16821.7 16968.6 18962.6 19261.6 19285.8 942.8 990.7 998.0 1045.1 1082.1 10443.6 10651.3 10661.4 10662.2 10798.4 558880.0 565918.0 581515.0 582002.0 583364.0 71523.0 85527.0 118956.0 122039.8 122843.4 1013.0 1051.1 1069.3 1071.2 1072.5 17227.4 17549.8 18109.9 18110.1 18246.3 47113.5 47653.5 48050.5 48183.0 48658.6 68021.7 68615.0 73862.3 77114.2 79697.8 7408.9 7437.1 7460.2 7548.5 7747.6 10330.4 10698.8 12047.9 12088.7 12310.4 7409.9 8364.9 10478.6 10839.5 10846.5 10296.8 10303.6 10518.8 10644.1 10776.9 10726.2 10742.7 10887.0 10921.6 11004.1 7284.8 7338.8 7371.9 7382.2 7607.9 8444.0 10719.8 10814.9 11026.6 11032.9 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5895.88 Median:5187.02 stddev:3092.49 (59.6%) stddev-sans-first:3083.15 17:29:22 INFO - PROCESS | 1671 | Values: 1455.3 1591.4 1623.2 1911.7 2045.7 7813.3 8443.0 8567.5 8575.0 8586.2 7217.7 7697.2 8147.9 8276.7 8562.9 2134.9 2376.2 2429.6 2433.9 2466.0 2394.2 2431.0 2431.9 2433.6 2434.6 2390.1 2397.7 2448.4 2458.4 2460.1 2403.6 2436.0 2447.9 2454.7 2459.3 2408.2 2445.4 2447.5 2454.9 2458.4 8504.0 8593.6 8595.4 8600.8 8610.6 5092.3 5172.9 5201.2 5208.9 5220.9 3428.6 3537.8 3583.0 3602.1 3609.6 1044.8 1060.0 1067.3 1075.8 1078.7 11287.7 11498.4 11526.7 11536.9 11553.9 4758.0 4777.4 4793.3 4823.7 4848.6 10159.0 10162.7 10165.9 10168.6 10177.4 5378.1 5412.9 5419.6 5428.4 5433.9 4259.7 4410.5 4680.9 4790.0 4797.1 3882.3 3939.6 3957.2 3997.1 3999.8 1119.6 1282.4 1296.7 1322.3 1322.7 1357.4 1380.4 1407.6 1412.7 1414.5 7867.1 8014.4 8021.0 8026.4 8035.2 475.9 476.3 486.5 487.2 493.4 6121.0 6192.6 6207.8 6207.8 6209.3 10065.3 10328.2 10455.5 10455.6 10461.8 9979.9 10202.1 10216.2 10244.6 10330.7 8014.9 8104.8 8115.2 8143.4 8202.4 7526.6 7587.2 7882.8 7972.2 8001.8 8167.7 9014.9 9352.0 9376.3 9425.4 9388.9 9529.8 9711.3 9729.4 9750.3 6596.1 6787.6 7040.8 7368.3 7491.6 7960.8 8016.9 8030.7 8032.4 8041.4 7104.8 7208.6 7233.6 7324.5 7392.2 6703.8 7091.1 7155.8 7160.9 7215.7 7396.1 7530.9 7572.8 7640.1 7642.8 6881.1 6886.1 6931.9 6935.7 6947.1 6691.4 6957.7 6960.1 6974.4 7011.5 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5731.99 Median:6649.89 stddev:1847.34 (27.8%) stddev-sans-first:1807.17 17:29:22 INFO - PROCESS | 1671 | Values: 312.2 315.8 321.9 322.2 328.5 6630.3 6676.6 6746.1 6747.4 6781.6 6622.7 6643.2 6656.6 6661.4 6666.8 4704.3 4754.8 4782.6 4878.7 4929.6 4826.6 4879.1 4882.5 4891.7 4894.0 4667.8 4809.9 4814.6 4821.7 4825.5 3929.3 4726.5 4853.4 4869.1 4897.9 4138.0 4146.9 4163.5 4167.2 4168.4 6360.7 6419.4 6421.7 6427.8 6439.3 5730.2 5737.9 5740.7 5743.4 5756.8 6695.1 7034.4 7053.7 7061.9 7073.8 4465.7 4491.6 4499.5 4533.8 4538.6 7283.0 7346.4 7349.9 7353.6 7359.4 4498.2 4528.0 4528.1 4532.6 4532.7 4578.7 4594.2 4599.6 4602.0 4602.2 5465.0 5467.3 5469.4 5470.0 5484.2 5745.9 5747.9 6376.3 7081.2 7109.5 1582.3 1620.8 1621.1 1622.2 1623.1 966.4 995.2 1021.2 1024.5 1041.0 6608.2 6677.2 6691.6 6692.8 6697.1 6120.7 7272.7 7347.9 7373.3 7377.9 6663.1 6672.2 6676.1 6676.9 6684.4 3747.0 3845.7 3883.6 3892.6 3899.5 6144.6 7693.8 7694.2 7700.2 7706.2 7482.6 7528.3 7536.9 7537.1 7553.0 7641.8 7659.8 7663.4 7672.8 7673.3 7048.5 7296.2 7331.2 7340.3 7345.7 7133.9 7172.4 7181.0 7193.5 7219.8 7612.0 7622.9 7628.0 7631.3 7655.9 4590.8 4595.9 4601.2 4608.5 4611.6 7057.5 7262.7 7267.3 7272.1 7294.6 6981.7 7030.8 7039.8 7041.3 7048.4 7010.8 7012.6 7017.7 7026.2 7033.7 5254.8 5584.9 6342.0 6514.3 6858.8 6932.9 7009.1 7030.6 7047.0 7088.6 6676.9 6719.9 6826.2 6834.3 6926.3 17:29:22 INFO - PROCESS | 1671 | 17:29:22 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18061.15 Median:34186.81 stddev:25671.78 (75.1%) stddev-sans-first:25710.68 17:29:22 INFO - PROCESS | 1671 | Values: 693.6 745.5 758.0 766.5 774.9 14697.6 14711.5 14789.6 14894.0 14897.7 13921.7 13975.9 14038.4 14045.5 14062.0 730.4 737.3 738.9 899.2 921.7 737.4 887.1 923.2 925.5 925.7 958.1 963.0 966.9 967.7 969.4 758.1 960.8 962.5 962.8 964.8 693.2 714.0 716.4 717.9 720.0 14598.3 14655.0 14700.5 14707.7 14736.6 12425.3 12597.6 12730.6 12745.9 12805.2 9989.0 10041.2 10069.2 10110.2 10377.3 3482.9 3518.5 3555.7 3558.4 3637.7 81989.6 83782.0 84052.0 84182.6 84213.0 9486.5 9588.8 9600.6 9823.7 10187.3 20576.3 22541.0 22568.7 22603.2 22604.7 7275.6 7318.6 7323.4 7351.3 7368.3 3954.4 3984.9 3992.9 4003.6 4058.2 3586.0 3629.6 3633.5 3634.9 3641.4 658.9 667.8 668.6 684.6 685.4 573.8 576.8 584.7 609.7 628.7 8243.4 8290.7 8370.4 8393.1 8466.0 481.8 499.0 571.7 578.9 595.3 2826.8 3765.9 3798.5 3829.8 3969.9 69748.7 87972.0 90051.0 90351.0 91036.0 79207.0 79628.6 80157.0 81267.6 81484.6 71409.9 71771.9 71833.6 72571.0 73279.6 7546.6 7551.5 7784.1 7803.1 8014.8 46897.3 47506.8 47564.3 47769.3 47872.5 63745.7 67705.0 68221.6 68661.0 68944.7 9649.7 9972.4 9975.1 10055.9 10658.3 10775.3 10800.7 10809.6 10883.7 11235.0 10216.6 10220.1 10290.2 10514.5 10654.6 10387.3 10394.2 10547.6 10667.7 10782.3 10184.3 10202.6 10478.5 10591.4 10600.8 7970.3 8830.0 8878.3 9029.8 9123.5 8815.8 8820.4 8884.7 8928.0 9006.2 17:29:22 INFO - PROCESS | 1671 | -------- Summary: end -------- 17:29:22 INFO - PROCESS | 1671 | 17:29:23 INFO - TEST-INFO | 1671: exit 0 17:29:23 INFO - TEST-OK | dromaeo_css | took 1114468ms 17:29:23 INFO - TEST-START | kraken 17:29:23 INFO - operating with platform_type : mac_ 17:29:23 INFO - Initialising browser for kraken test... 17:29:23 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpwET4PO/profile http://localhost:49270/getInfo.html) 17:29:25 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 17:29:25 INFO - PROCESS | 1676 | colorDepth:24 17:29:25 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 17:29:25 INFO - PROCESS | 1676 | __metrics 17:29:25 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:29:25 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:29:26 INFO - TEST-INFO | 1676: exit 0 17:29:26 INFO - Browser initialized. 17:29:26 INFO - Running cycle 1/1 for kraken test... 17:29:26 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpwET4PO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:38 INFO - PROCESS | 1678 | RSS: Main: 243392512 17:29:38 INFO - PROCESS | 1678 | 17:29:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:41 INFO - PROCESS | 1678 | RSS: Main: 290406400 17:29:41 INFO - PROCESS | 1678 | 17:29:44 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:29:44 INFO - PROCESS | 1678 | RSS: Main: 300212224 17:29:44 INFO - PROCESS | 1678 | 17:29:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:29:48 INFO - PROCESS | 1678 | RSS: Main: 286646272 17:29:48 INFO - PROCESS | 1678 | 17:29:50 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:29:51 INFO - PROCESS | 1678 | RSS: Main: 289632256 17:29:51 INFO - PROCESS | 1678 | 17:29:53 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:53 INFO - PROCESS | 1678 | RSS: Main: 291368960 17:29:53 INFO - PROCESS | 1678 | 17:29:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:57 INFO - PROCESS | 1678 | RSS: Main: 292892672 17:29:57 INFO - PROCESS | 1678 | 17:30:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:30:00 INFO - PROCESS | 1678 | RSS: Main: 291995648 17:30:00 INFO - PROCESS | 1678 | 17:30:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:30:03 INFO - PROCESS | 1678 | RSS: Main: 292536320 17:30:03 INFO - PROCESS | 1678 | 17:30:05 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:30:06 INFO - PROCESS | 1678 | RSS: Main: 325230592 17:30:06 INFO - PROCESS | 1678 | 17:30:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:30:08 INFO - PROCESS | 1678 | RSS: Main: 324579328 17:30:08 INFO - PROCESS | 1678 | 17:30:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:30:11 INFO - PROCESS | 1678 | RSS: Main: 330379264 17:30:11 INFO - PROCESS | 1678 | 17:30:13 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:30:14 INFO - PROCESS | 1678 | RSS: Main: 332517376 17:30:14 INFO - PROCESS | 1678 | 17:30:16 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:30:17 INFO - PROCESS | 1678 | RSS: Main: 333168640 17:30:17 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:30:19 INFO - PROCESS | 1678 | RSS: Main: 393199616 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | __start_tp_report 17:30:19 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 17:30:19 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 17:30:19 INFO - PROCESS | 1678 | |i|pagename|runs| 17:30:19 INFO - PROCESS | 1678 | |0;ai-astar;111;109;111;110;110;111;117;109;109;111 17:30:19 INFO - PROCESS | 1678 | |1;audio-beat-detection;159;120;142;157;119;141;137;119;159;119 17:30:19 INFO - PROCESS | 1678 | |2;audio-dft;184;184;184;187;185;185;188;188;181;185 17:30:19 INFO - PROCESS | 1678 | |3;audio-fft;76;78;78;80;64;81;46;96;101;80 17:30:19 INFO - PROCESS | 1678 | |4;audio-oscillator;93;90;127;78;80;78;114;77;80;117 17:30:19 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;95;87;90;91;90;89;90;88;90;87 17:30:19 INFO - PROCESS | 1678 | |6;imaging-darkroom;93;94;96;96;94;95;96;97;95;95 17:30:19 INFO - PROCESS | 1678 | |7;imaging-desaturate;86;87;86;87;90;87;85;84;86;86 17:30:19 INFO - PROCESS | 1678 | |8;json-parse-financial;54;57;55;54;56;54;53;63;55;53 17:30:19 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;66;63;70;81;74;71;66;68;67;67 17:30:19 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;86;81;82;83;83;83;83;80;82;85 17:30:19 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;126;131;130;130;120;130;124;124;131;117 17:30:19 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;139;127;140;138;140;127;139;138;136;138 17:30:19 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;67;66;68;66;67;66;67;68;67 17:30:19 INFO - PROCESS | 1678 | __end_tp_report 17:30:19 INFO - PROCESS | 1678 | __start_cc_report 17:30:19 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1213 17:30:19 INFO - PROCESS | 1678 | __end_cc_report 17:30:19 INFO - PROCESS | 1678 | __startTimestamp1458174619418__endTimestamp 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | ------- Summary: start ------- 17:30:19 INFO - PROCESS | 1678 | Number of tests: 14 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.35 (2.1%) stddev-sans-first:2.49 17:30:19 INFO - PROCESS | 1678 | Values: 111.0 109.0 111.0 110.0 110.0 111.0 117.0 109.0 109.0 111.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:141.50 stddev:17.22 (12.2%) stddev-sans-first:16.36 17:30:19 INFO - PROCESS | 1678 | Values: 159.0 120.0 142.0 157.0 119.0 141.0 137.0 119.0 159.0 119.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:2.13 (1.2%) stddev-sans-first:2.22 17:30:19 INFO - PROCESS | 1678 | Values: 184.0 184.0 184.0 187.0 185.0 185.0 188.0 188.0 181.0 185.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:78.00 Median:79.00 stddev:15.25 (19.3%) stddev-sans-first:16.16 17:30:19 INFO - PROCESS | 1678 | Values: 76.0 78.0 78.0 80.0 64.0 81.0 46.0 96.0 101.0 80.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:79.00 stddev:18.93 (24.0%) stddev-sans-first:20.08 17:30:19 INFO - PROCESS | 1678 | Values: 93.0 90.0 127.0 78.0 80.0 78.0 114.0 77.0 80.0 117.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:89.70 Median:90.00 stddev:2.31 (2.6%) stddev-sans-first:1.45 17:30:19 INFO - PROCESS | 1678 | Values: 95.0 87.0 90.0 91.0 90.0 89.0 90.0 88.0 90.0 87.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.50 stddev:1.20 (1.3%) stddev-sans-first:1.00 17:30:19 INFO - PROCESS | 1678 | Values: 93.0 94.0 96.0 96.0 94.0 95.0 96.0 97.0 95.0 95.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.67 17:30:19 INFO - PROCESS | 1678 | Values: 86.0 87.0 86.0 87.0 90.0 87.0 85.0 84.0 86.0 86.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:2.95 (5.4%) stddev-sans-first:3.09 17:30:19 INFO - PROCESS | 1678 | Values: 54.0 57.0 55.0 54.0 56.0 54.0 53.0 63.0 55.0 53.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:5.12 (7.4%) stddev-sans-first:5.29 17:30:19 INFO - PROCESS | 1678 | Values: 66.0 63.0 70.0 81.0 74.0 71.0 66.0 68.0 67.0 67.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.75 (2.1%) stddev-sans-first:1.42 17:30:19 INFO - PROCESS | 1678 | Values: 86.0 81.0 82.0 83.0 83.0 83.0 83.0 80.0 82.0 85.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:130.00 stddev:4.97 (3.8%) stddev-sans-first:5.27 17:30:19 INFO - PROCESS | 1678 | Values: 126.0 131.0 130.0 130.0 120.0 130.0 124.0 124.0 131.0 117.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.20 Median:138.50 stddev:4.98 (3.6%) stddev-sans-first:5.18 17:30:19 INFO - PROCESS | 1678 | Values: 139.0 127.0 140.0 138.0 140.0 127.0 139.0 138.0 136.0 138.0 17:30:19 INFO - PROCESS | 1678 | 17:30:19 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 17:30:19 INFO - PROCESS | 1678 | Values: 67.0 67.0 66.0 68.0 66.0 67.0 66.0 67.0 68.0 67.0 17:30:19 INFO - PROCESS | 1678 | -------- Summary: end -------- 17:30:19 INFO - PROCESS | 1678 | 17:30:20 INFO - TEST-INFO | 1678: exit 0 17:30:20 INFO - TEST-OK | kraken | took 56799ms 17:30:20 INFO - SUITE-END | took 1171s 17:30:20 INFO - Completed test suite (00:19:31) 17:30:20 INFO - javascript benchmark 17:30:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3404.3872103021454, 3473.982630086849, 3474.305138972203, 3489.180042689967, 3537.929241415172, 5556.499915007648, 5597.748101335439, 5620.606557540974, 5637.718114094294, 5676.262085928829, 5599.776008959647, 5617.466340697627, 5656.688882111493, 5748.5975981681295, 5809.244798176232, 5056.519630635084, 5111.182210846266, 5126.538611524962, 5144.845654630367, 5201.921971170435, 5157.2006339017325, 5178.482151784829, 5210.062188806013, 5230.215467679859, 5277.076511610472, 5035.874103147451, 5046.394432668085, 5129.563987061104, 5147.922781158286, 5151.871203219931, 5184.870378240536, 5190.948090519122, 5194.013137503862, 5203.401608814959, 5220.164773636238, 5103.464136265713, 5120.231965205249, 5143.3570803649545, 5149.588032957355, 5183.870403239912, 5461.69960652164, 5570.053090974544, 5572.331320241597, 5590.385057643656, 5591.440855914417, 6046.645266119765, 6058.946529921364, 6077.0276755719315, 6092.846225312422, 6095.86063177464, 6022.578419510636, 6034.0, 6193.84515387119, 6243.812685619393, 6264.27960784511, 5687.60186786921, 5715.5427565794635, 5721.370649228582, 5740.7703691852275, 5799.014167591477, 5166.328377311001, 6155.10750941111, 6191.19514463126, 6205.565610407319, 6222.844428889314, 6088.756449742049, 6091.482224011009, 6098.635072127691, 6101.023836186189, 6123.418275263932, 6059.818205453844, 6202.472789812917, 6220.906686399708, 6229.314775374705, 6236.812895613139, 5973.940260597426, 6092.695365231721, 6100.359462256488, 6110.541709371815, 6142.754289828356, 4618.67669263155, 6155.599886007395, 6166.167567378347, 6191.226096737908, 6201.162843016135, 4861.246506791453, 4867.464578896319, 4876.756162191876, 4885.780139893643, 4914.877128071756, 3670.6696397324367, 4269.615734583902, 4329.935050974238, 4365.236083685342, 4394.2749446340995, 5592.245046918695, 5595.496405323541, 5622.212890195376, 5713.657180569179, 5717.771289148471, 6121.357257487989, 6177.722002509898, 6185.536084793658, 6194.287656919512, 6198.411150940653, 5545.085060964976, 5568.053430916673, 5615.494605485526, 5622.269105016404, 5639.069553523705, 5271.0, 5297.735113244323, 5325.227841962894, 5363.544098751572, 5375.408705042442, 6192.5974811638, 6200.596961197418, 6210.223722034746, 6222.502199824094, 6222.782202622887, 6069.605475644069, 6165.938340616716, 6181.505479561534, 6189.845253868509, 6208.906866396917, 5288.762005709676, 6193.256809182927, 6242.375762423721, 6262.060690896402, 6284.905726414016, 6061.727222275096, 6091.908621370594, 6103.6032657877095, 6115.541334400027, 6117.296510901126, 5863.794767183128, 6158.692065396802, 6171.321154672893, 6200.937990620036, 6202.2867370253, 5919.260092488439, 5958.0, 5962.344142144448, 5971.701414929149, 5974.133750606051, 5959.73181206838, 5960.701964901651, 5963.135345374983, 5978.760849565969, 5982.880342393215, 5807.680577568274, 5825.038868586806, 5826.213461182856, 5826.41735826414, 5831.1836342912875, 5128.6153538485505, 5922.555808314308, 5924.555658325557, 5942.494887934401, 6065.090236464565, 5877.764889404376, 5892.234009578728, 5894.174815525916, 5936.910946335722, 5939.584229103922], "unit": "score", "name": "dojo.html", "value": 5606.432942339913}, {"lowerIsBetter": false, "replicates": [456.9581354511715, 585.9803941142411, 600.7236671131279, 640.7693230437042, 653.428250281004, 36675.81662091689, 37347.87956361307, 37423.812880935555, 37542.0, 37554.248915021686, 37677.623223767754, 38349.61650383495, 38358.04104897372, 38388.42417363742, 38403.615963840355, 9340.065993400674, 9555.235581153525, 9567.52162391881, 9580.473073980927, 9588.952055239713, 9492.952535237315, 9674.806503869919, 9678.177354924805, 9689.176420004309, 9692.418454892693, 9636.518174091303, 9718.396464583335, 9728.951355243249, 9732.07545283197, 9733.2213422926, 9622.470764107971, 9706.660266890625, 9710.417374957526, 9710.514474276259, 9714.562844672007, 9548.809023819485, 9689.224862011022, 9690.46702431366, 9702.029797020312, 9703.854442183372, 37326.626733732584, 38079.23841523154, 38581.80709096465, 38601.61398386008, 38671.0, 3256.9837150814333, 3266.3304022675293, 3373.7975721456546, 3374.510695949098, 3485.4597537381746, 29037.0, 29280.68236929322, 29342.853285733647, 29689.851550742325, 29779.957701480344, 2686.0867305116158, 2714.09077958884, 2725.250556097089, 2846.5303224967856, 2893.7250961158866, 461000.0, 463863.0, 463998.0, 465029.674851627, 465982.0, 52903.470965290624, 59954.80090398255, 60301.69849150814, 60659.69670151621, 60785.0, 51241.487585124414, 64389.0, 65657.67171164209, 65767.0, 65998.67000664966, 16062.0, 16253.59366015859, 16268.430604928772, 16273.349066037226, 16285.755713664304, 11468.426578671033, 12473.937630311972, 12522.686932826753, 12566.497340106476, 12795.296258705861, 18753.90623046876, 18769.155388007573, 18818.0, 18826.341078062476, 18841.905790471235, 7496.662650180755, 7774.105977812624, 8797.252233560092, 8902.599383027778, 9001.909980900107, 938.9671361502315, 954.6467806911487, 1014.1633152648947, 1016.4815943868532, 1134.3420815926743, 28947.710522894922, 29381.706182938324, 29570.408591828043, 29634.0, 31532.52701209438, 991.4299277915228, 1147.4148184426003, 1167.3404526442532, 1188.619641714643, 1213.168979249217, 14829.18439485817, 14854.925725371304, 15108.924455377653, 15156.0, 15219.086854788748, 510085.0, 511015.0, 516869.0, 517243.0, 518334.0, 57901.71049144812, 58377.416225837194, 58471.70764146152, 58583.0, 58696.0, 1272.0, 1452.1142103316968, 1497.7229212595705, 1499.0406140070363, 1559.7660350947222, 24756.38109047288, 28064.719352807027, 28160.014399495918, 28420.85789571039, 28825.711742882304, 45740.31389529226, 46270.305945410175, 46575.53424465848, 46676.53323466722, 46686.83282917954, 348267.0, 351300.0, 351582.0, 351771.0, 352077.0, 22680.979355929354, 32133.678663214003, 33091.83454082714, 33105.0, 33121.33757324888, 40877.79561102176, 42290.57709422866, 42302.36546451867, 42622.0, 43563.34654980114, 28675.0, 36142.63857361393, 36301.45547816838, 36929.0, 37015.81492092522, 35373.115672108404, 35551.644483555865, 36016.27967440689, 36109.458358124124, 36184.0, 35004.299914002084, 35214.94355169349, 35874.923752287476, 36063.63936360603, 36191.0, 22863.657045144668, 30829.69170308358, 31194.797534726855, 31564.053078407684, 31732.206694832814, 20346.89826550917, 22001.779982199972, 23894.751568933294, 24167.39581510406, 24408.779561022235], "unit": "score", "name": "ext.html", "value": 19212.73492790591}, {"lowerIsBetter": false, "replicates": [354.35861091424516, 354.5019247956621, 355.3248827228266, 365.1000284299202, 366.0427980830128, 15734.370625174994, 19130.0, 19841.0, 19841.0, 19937.700934485994, 18943.33698320559, 19192.32826851057, 19893.801061989376, 19951.600967980667, 19980.500487487785, 5859.589828711981, 6004.759809607611, 6076.848078798022, 6085.995810691231, 6087.086936959469, 4205.936910946339, 4485.506594274627, 6001.21984142061, 6339.080833279172, 6635.0, 6563.901541476882, 6575.967120164392, 6579.703913323888, 6583.80248592543, 6584.2098948126295, 6400.071989561511, 6445.097686323918, 6538.1827271591055, 6572.375624315682, 6579.868402631921, 3734.4211647194456, 5391.3799913009725, 5604.85987850307, 5616.410276920906, 5664.773409063632, 22132.0, 22955.196568120034, 22958.19646312371, 24475.26574202777, 24749.010039598394, 2224.5773303072365, 2281.2243837095466, 2447.816413768957, 2503.9358272734016, 2563.3591602099477, 9296.39573427725, 9372.484513351763, 9676.95161524195, 9689.51552422383, 9720.465374404404, 1717.8883372580742, 1726.6287748134212, 1727.2745446912327, 1778.0309731196528, 1817.5546990987293, 98661.50669246679, 99029.50485247599, 100058.49970750173, 100433.99566004393, 101994.0, 10667.19996000303, 10848.78302433947, 10914.072303854262, 10917.945410272898, 10982.395968221665, 13080.803787943189, 13163.0, 13170.341482925814, 13178.472861085449, 13190.60428187156, 8184.713535026245, 8367.246947774607, 8374.985005398052, 8449.704260350858, 8459.873101903477, 6626.7017984190825, 8524.190201930807, 8527.0, 8528.658853645784, 8643.524606146722, 3633.3459977204357, 3659.780413175218, 3747.063234191452, 4267.125239325931, 4331.328644060176, 1709.384621536246, 1797.343969451141, 1802.9356386936884, 1807.8282563156479, 1812.7099664053687, 786.811165320319, 805.9113497515268, 968.5593055160026, 1014.7209517382779, 1016.3495362967707, 16821.663566728843, 16968.57578560546, 18962.62074758497, 19261.614767704566, 19285.807141928683, 942.7548837302351, 990.6631745206664, 997.960081596728, 1045.137761346892, 1082.1396989393452, 10443.582256709798, 10651.30766500175, 10661.360318380766, 10662.200334974908, 10798.352098874093, 558880.0, 565918.0, 581515.0, 582002.0, 583364.0, 71523.0, 85527.0, 118956.0, 122039.77960220462, 122843.38578307051, 1012.9949350253202, 1051.0540513537724, 1069.3209811769427, 1071.1751950997843, 1072.5012869015945, 17227.3970411035, 17549.824501754818, 18109.909450452662, 18110.094495275447, 18246.270149193882, 47113.52886471091, 47653.523464764905, 48050.519494804605, 48183.0, 48658.56707164698, 68021.65989170023, 68615.0, 73862.26137738554, 77114.22885771295, 79697.8045329309, 7408.888866666896, 7437.066362745617, 7460.216677249028, 7548.4716069874585, 7747.573883436465, 10330.380177189392, 10698.786024279316, 12047.939760301142, 12088.730683278129, 12310.446029928495, 7409.851802964018, 8364.87452688198, 10478.63324783629, 10839.458027098455, 10846.45767711627, 10296.845547316947, 10303.587856485656, 10518.789624207626, 10644.148468122377, 10776.892231077589, 10726.249162558546, 10742.677719668422, 10886.965738254854, 10921.617743379262, 11004.119670426187, 7284.817879553054, 7338.77983660491, 7371.852562948604, 7382.187959324578, 7607.923920760722, 8443.95778021106, 10719.785604287714, 10814.945925270324, 11026.558937642405, 11032.944835275772], "unit": "score", "name": "jquery.html", "value": 9100.057138643884}, {"lowerIsBetter": false, "replicates": [1455.3160014793043, 1591.403223791078, 1623.2451909861911, 1911.696405830973, 2045.7033730109126, 7813.335866451352, 8442.957785211072, 8567.485950842954, 8575.01387340456, 8586.184312490312, 7217.675204615792, 7697.153313135551, 8147.9407677002055, 8276.668933242678, 8562.871556926651, 2134.9146034158694, 2376.1683410806168, 2429.6112621980487, 2433.926982190528, 2466.001269485861, 2394.1859767678984, 2430.963535546968, 2431.8540887546715, 2433.5862903306393, 2434.573949558829, 2390.067873529325, 2397.652340410639, 2448.4123810285582, 2458.3731148557094, 2460.1020627470934, 2403.627437747152, 2435.9756402436014, 2447.9143229986953, 2454.6563481112657, 2459.3359792855827, 2408.1812183857573, 2445.437549363656, 2447.473793134485, 2454.901803927841, 2458.43456005118, 8504.02203746571, 8593.570321483963, 8595.44129631572, 8600.827983440358, 8610.612522436506, 5092.337996060525, 5172.870678233075, 5201.1678131498775, 5208.947910520884, 5220.947790522084, 3428.63999280077, 3537.7700449470703, 3582.960941327012, 3602.0814692253307, 3609.5848977367677, 1044.764927891226, 1059.9576016959313, 1067.2635881241995, 1075.8493810866485, 1078.7087486378712, 11287.717807054807, 11498.42507874603, 11526.711832204179, 11536.942315288454, 11553.884461155365, 4758.0, 4777.4267087949665, 4793.32893394925, 4823.710577365299, 4848.587870031016, 10158.98410158993, 10162.745931351776, 10165.949170254102, 10168.644097456554, 10177.440240786827, 5378.058839703036, 5412.91880621791, 5419.6477228980775, 5428.430014848463, 5433.940381625545, 4259.74441533509, 4410.4927933287445, 4680.9297860532115, 4789.994101238709, 4797.088553174885, 3882.3400021996326, 3939.625735555118, 3957.248122856648, 3997.120633460634, 3999.7800120993043, 1119.6081371519904, 1282.4293189530756, 1296.695276609996, 1322.272749987503, 1322.6759443936296, 1357.382391012087, 1380.4133243371527, 1407.56365526685, 1412.6962703018694, 1414.5402744108, 7867.055953285528, 8014.398920080901, 8021.0, 8026.357891368676, 8035.196480351918, 475.89768199837204, 476.3022172517279, 486.48432661379053, 487.19369443570946, 493.3758795124099, 6121.0, 6192.5974811638, 6207.782727604512, 6207.782727604603, 6209.2548894133, 10065.295429319878, 10328.173746100294, 10455.477226138815, 10455.634052808115, 10461.84919658837, 9979.900200998043, 10202.081812636898, 10216.233782466195, 10244.641437549799, 10330.741731456774, 8014.879776803353, 8104.756857294173, 8115.188481151838, 8143.389245806469, 8202.38482113844, 7526.569951709158, 7587.203343649058, 7882.842343153219, 7972.162922893012, 8001.799955001172, 8167.673293068211, 9014.909850901407, 9352.0, 9376.343655944018, 9425.434473931311, 9388.859167112361, 9529.809403811747, 9711.3202075854, 9729.416235025921, 9750.268729845147, 6596.076549283008, 6787.5588086774205, 7040.823979400556, 7368.336849683555, 7491.550506969599, 7960.761177164694, 8016.879746803919, 8030.718924837603, 8032.437729358889, 8041.396895232764, 7104.822379440556, 7208.603526805866, 7233.63831808418, 7324.450666199949, 7392.22381649919, 6703.832404189934, 7091.078159839188, 7155.785326440215, 7160.892586611101, 7215.747448839265, 7396.0754905636795, 7530.9246907532415, 7572.7728168155045, 7640.121386040676, 7642.8089297768, 6881.13985751781, 6886.070380498569, 6931.930680693128, 6935.687894044881, 6947.131608548932, 6691.397844093741, 6957.721691132298, 6960.095187625576, 6974.442044636316, 7011.544249623758], "unit": "score", "name": "mootools.html", "value": 4750.861853103331}, {"lowerIsBetter": false, "replicates": [312.17429897920005, 315.8247172819086, 321.92273854274964, 322.17683817845403, 328.50067896796884, 6630.270670226278, 6676.566023208488, 6746.077367950135, 6747.39273465388, 6781.627010514432, 6622.701978410971, 6643.202815662115, 6656.567323123993, 6661.400473957343, 6666.799996000128, 4704.341392205086, 4754.786034628432, 4782.593479554224, 4878.682885612441, 4929.556339929406, 4826.638002149835, 4879.121758083544, 4882.462929077817, 4891.682040667363, 4893.975530122362, 4667.76661166942, 4809.927851082237, 4814.590759785422, 4821.662483626147, 4825.469198388175, 3929.3123703352085, 4726.456457507396, 4853.3690620219495, 4869.099216644914, 4897.8775530611665, 4138.02756352257, 4146.896327591804, 4163.500379954395, 4167.249895018896, 4168.43726096976, 6360.650164240965, 6419.35806419359, 6421.711023003976, 6427.8393040173905, 6439.259485159219, 5730.226419433365, 5737.942620573825, 5740.655560666373, 5743.396943320933, 5756.82729518111, 6695.096162018162, 7034.366906978396, 7053.68258428372, 7061.858762824715, 7073.752418665322, 4465.709728867646, 4491.6182124519455, 4499.482559505666, 4533.77331133442, 4538.636909047268, 7283.0, 7346.4122870170795, 7349.853002939964, 7353.632318384113, 7359.411247100219, 4498.190325741398, 4527.977360113245, 4528.117017181684, 4532.637389008937, 4532.7280363178315, 4578.725276483422, 4594.150082234797, 4599.563041511051, 4601.987562736193, 4602.217623004098, 5464.972675136599, 5467.343918729778, 5469.398366179717, 5470.042742520043, 5484.177373393943, 5745.913811292834, 5747.942520574825, 6376.29860715321, 7081.150261968597, 7109.502334836615, 1582.2800625715272, 1620.8491970700934, 1621.1488968291505, 1622.1970124788306, 1623.091069001363, 966.4201479112477, 995.2137811129271, 1021.2391768132641, 1024.4775164665925, 1040.953157107932, 6608.2400523939405, 6677.165354330708, 6691.631960242234, 6692.765753198614, 6697.09589205451, 6120.714649923566, 7272.672729727175, 7347.88978165328, 7373.33639972405, 7377.9262207378315, 6663.06717059612, 6672.165979252593, 6676.132102826698, 6676.933230667728, 6684.364985326386, 3747.0, 3845.692344612424, 3883.5533913599734, 3892.630200130983, 3899.454076429302, 6144.600600960924, 7693.769186924401, 7694.153643099255, 7700.229977002255, 7706.152323244439, 7482.625868706543, 7528.284812942762, 7536.886946695804, 7537.057867766529, 7552.962235188898, 7641.808954776175, 7659.770206893802, 7663.42899705559, 7672.80817979555, 7673.309402153833, 7048.541844780073, 7296.1974182838785, 7331.2302208267365, 7340.339369456775, 7345.70617175307, 7133.892991605234, 7172.426205903619, 7181.0, 7193.460490463341, 7219.783406497603, 7612.0, 7622.885656715042, 7628.0, 7631.3131818136635, 7655.923440765521, 4590.793414296431, 4595.885102872455, 4601.194790911644, 4608.5161058088415, 4611.6310695144975, 7057.541259818096, 7262.745803896838, 7267.273272672691, 7272.127344718668, 7294.562326260229, 6981.720731170696, 7030.789076327718, 7039.753608623673, 7041.260667629826, 7048.365647091581, 7010.75462358815, 7012.5624247030255, 7017.719291228498, 7026.227115017242, 7033.678885967721, 5254.763535640829, 5584.910942366199, 6342.048692696132, 6514.250861151028, 6858.828529286808, 6932.861342773015, 7009.0537777399395, 7030.61331626745, 7046.964765176142, 7088.574685518885, 6676.89984650221, 6719.899201511884, 6826.249112597511, 6834.282400347892, 6926.307369263033], "unit": "score", "name": "prototype.html", "value": 5107.029812973885}, {"lowerIsBetter": false, "replicates": [693.6254422611789, 745.4707157917878, 757.9772606821797, 766.5285849202738, 774.8760198368255, 14697.632559186026, 14711.48509802157, 14789.556313310617, 14894.0, 14897.702045959088, 13921.651958701012, 13975.860241397582, 14038.438462461514, 14045.50840720575, 14062.0, 730.3536370312286, 737.2516895351223, 738.9076365454318, 899.1682693508511, 921.7465197070792, 737.3695490355749, 887.0774394629577, 923.2429407885503, 925.5002298758662, 925.7037747920668, 958.0850287974968, 962.956666949989, 966.8694726211942, 967.7290358699576, 969.3844408800427, 758.0978635423883, 960.7694153403133, 962.5427921737154, 962.7978124593843, 964.768455570665, 693.2062788107588, 713.9750108746169, 716.369594756616, 717.8779607466744, 720.0387482710588, 14598.270086495633, 14655.0, 14700.485483008044, 14707.705845883129, 14736.631584210481, 12425.254484730855, 12597.559085432058, 12730.554430594884, 12745.87254127456, 12805.231686098863, 9989.0, 10041.246906482043, 10069.194464442828, 10110.24173187014, 10377.273590848643, 3482.94775578364, 3518.5249991251367, 3555.7333200010103, 3558.3772839753196, 3637.7453578249533, 81989.59005204936, 83782.0, 84052.0, 84182.57908710478, 84213.0, 9486.525673716287, 9588.808223835484, 9600.615975361046, 9823.705288841345, 10187.337823041478, 20576.27983020617, 22540.985655645534, 22568.66147007796, 22603.208887688852, 22604.660930086062, 7275.636218189175, 7318.634068296564, 7323.363589107917, 7351.301626345488, 7368.263173682696, 3954.3870700040966, 3984.86052988144, 3992.920141597152, 4003.559608443069, 4058.2086493133556, 3585.982070089633, 3629.637036296402, 3633.5276414066, 3634.909127271839, 3641.380965235863, 658.9439897608661, 667.8497338098889, 668.6122049211446, 684.5618803965466, 685.3797313431353, 573.7963023126813, 576.7952376906222, 584.6813486649786, 609.6739591388712, 628.6573817269508, 8243.381746368927, 8290.668373265122, 8370.372222083368, 8393.076761556224, 8465.992035512469, 481.7639356715184, 499.03187815637546, 571.7198572699348, 578.8871170121786, 595.2618752746649, 2826.7879909006906, 3765.9246815063543, 3798.4682144499793, 3829.751066180689, 3969.861054863066, 69748.6512567434, 87972.0, 90051.0, 90351.0, 91036.0, 79207.0, 79628.6018569915, 80157.0, 81267.5936620325, 81484.59257703793, 71409.92885106728, 71771.92342114769, 71833.64083179655, 72571.0, 73279.63360183165, 7546.626555666519, 7551.509151905108, 7784.143744188248, 7803.102643196105, 8014.799630009296, 46897.29654055124, 47506.76246618745, 47564.2865357013, 47769.28346074742, 47872.521274786806, 63745.68127159335, 67705.0, 68221.63556728937, 68661.0, 68944.6552767233, 9649.710508684751, 9972.40165590038, 9975.102240798364, 10055.899441005497, 10658.253922225369, 10775.273478427132, 10800.675979720621, 10809.621663242064, 10883.727906802393, 11235.0, 10216.591336346462, 10220.080192782685, 10290.176785856964, 10514.526846292089, 10654.57381704723, 10387.272890897564, 10394.22043346737, 10547.630832920811, 10667.679969600924, 10782.299150555189, 10184.287099902936, 10202.59189632436, 10478.528466219192, 10591.417472039111, 10600.840987385041, 7970.322522585645, 8830.02869684347, 8878.289736820909, 9029.77425564366, 9123.498207598646, 8815.779605509913, 8820.382573219813, 8884.73345799627, 8928.0, 9006.234470069856], "unit": "score", "name": "yui.html", "value": 6750.832610143426}], "name": "dromaeo_css", "value": 7372.399585076063}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 111.0, 110.0, 110.0, 111.0, 117.0, 109.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 142.0, 157.0, 119.0, 141.0, 137.0, 119.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.2}, {"lowerIsBetter": true, "replicates": [184.0, 184.0, 184.0, 187.0, 185.0, 185.0, 188.0, 188.0, 181.0, 185.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [76.0, 78.0, 78.0, 80.0, 64.0, 81.0, 46.0, 96.0, 101.0, 80.0], "unit": "score", "name": "audio-fft", "value": 78.0}, {"lowerIsBetter": true, "replicates": [93.0, 90.0, 127.0, 78.0, 80.0, 78.0, 114.0, 77.0, 80.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.4}, {"lowerIsBetter": true, "replicates": [95.0, 87.0, 90.0, 91.0, 90.0, 89.0, 90.0, 88.0, 90.0, 87.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.7}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 96.0, 96.0, 94.0, 95.0, 96.0, 97.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 87.0, 90.0, 87.0, 85.0, 84.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.4}, {"lowerIsBetter": true, "replicates": [54.0, 57.0, 55.0, 54.0, 56.0, 54.0, 53.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [66.0, 63.0, 70.0, 81.0, 74.0, 71.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [86.0, 81.0, 82.0, 83.0, 83.0, 83.0, 83.0, 80.0, 82.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [126.0, 131.0, 130.0, 130.0, 120.0, 130.0, 124.0, 124.0, 131.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.3}, {"lowerIsBetter": true, "replicates": [139.0, 127.0, 140.0, 138.0, 140.0, 127.0, 139.0, 138.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 68.0, 66.0, 67.0, 66.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1412.6000000000001}]} 17:30:20 INFO - Return code: 0 17:30:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:30:20 ERROR - # TBPL SUCCESS # 17:30:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:30:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:30:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:30:20 INFO - 2016-03-16 17:30:20.711 screenresolution[1683:10196] starting screenresolution argv=screenresolution get 17:30:20 INFO - 2016-03-16 17:30:20.713 screenresolution[1683:10196] Display 0: 1600x1200x32@60 17:30:20 INFO - 2016-03-16 17:30:20.719 screenresolution[1684:10200] starting screenresolution argv=screenresolution list 17:30:20 INFO - Available Modes on Display 0 17:30:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:30:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:30:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:30:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:30:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:30:20 INFO - Intel Iris: 17:30:20 INFO - Chipset Model: Intel Iris 17:30:20 INFO - Type: GPU 17:30:20 INFO - Bus: Built-In 17:30:20 INFO - VRAM (Dynamic, Max): 1536 MB 17:30:20 INFO - Vendor: Intel (0x8086) 17:30:20 INFO - Device ID: 0x0a2e 17:30:20 INFO - Revision ID: 0x0009 17:30:20 INFO - Displays: 17:30:20 INFO - Display: 17:30:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:30:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:30:20 INFO - Display Serial Number: 1600x1200 60 17:30:20 INFO - Main Display: Yes 17:30:20 INFO - Mirror: Off 17:30:20 INFO - Online: Yes 17:30:20 INFO - Rotation: Supported 17:30:20 INFO - Return code: 0 17:30:20 INFO - Running post-action listener: _resource_record_post_action 17:30:20 INFO - Running post-run listener: _resource_record_post_run 17:30:22 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 34225664; Write bytes: 706088960; Read time: 348; Write time: 2105 17:30:22 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387193344; Write bytes: 380999168; Read time: 29728; Write time: 716 17:30:22 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 33304064; Write bytes: 302270976; Read time: 335; Write time: 1338 17:30:22 INFO - Running post-run listener: _upload_blobber_files 17:30:22 INFO - Blob upload gear active. 17:30:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:30:22 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 17:30:22 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'] 17:30:22 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 17:30:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:30:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:30:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:30:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:23 INFO - (blobuploader) - INFO - Done attempting. 17:30:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:30:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:30:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:30:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:30:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:30:24 INFO - (blobuploader) - INFO - Done attempting. 17:30:24 INFO - (blobuploader) - INFO - Iteration through files over. 17:30:24 INFO - Return code: 0 17:30:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:30:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:30:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1783ac7c3a6b67a3f975ca8c21fb5fda635e4af7ac669536d3796c66e0598964caca88594f17d161e649a76b94a80d46ec8529fffe84789d8c0505105d2ca86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ca0c29b1e04c783528f0ab0b69f0c5c62be8f5b8e8582d190436ddf17a63b24ffa8156d86e64d00a968bf2ac5a9cfdeff95cf596634ba86e3ec4bb08f8d5bca"} 17:30:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:30:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:30:24 INFO - Contents: 17:30:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1783ac7c3a6b67a3f975ca8c21fb5fda635e4af7ac669536d3796c66e0598964caca88594f17d161e649a76b94a80d46ec8529fffe84789d8c0505105d2ca86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ca0c29b1e04c783528f0ab0b69f0c5c62be8f5b8e8582d190436ddf17a63b24ffa8156d86e64d00a968bf2ac5a9cfdeff95cf596634ba86e3ec4bb08f8d5bca"} 17:30:24 INFO - Running post-run listener: copy_logs_to_upload_dir 17:30:24 INFO - Copying logs to upload dir... 17:30:24 INFO - mkdir: /builds/slave/test/build/upload/logs 17:30:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.167940 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-03-16 17:30:24.800467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:30:24.804260) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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/b1783ac7c3a6b67a3f975ca8c21fb5fda635e4af7ac669536d3796c66e0598964caca88594f17d161e649a76b94a80d46ec8529fffe84789d8c0505105d2ca86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ca0c29b1e04c783528f0ab0b69f0c5c62be8f5b8e8582d190436ddf17a63b24ffa8156d86e64d00a968bf2ac5a9cfdeff95cf596634ba86e3ec4bb08f8d5bca"} build_url:https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/Rjuj08MPTAKJOZuHyvsh3Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b1783ac7c3a6b67a3f975ca8c21fb5fda635e4af7ac669536d3796c66e0598964caca88594f17d161e649a76b94a80d46ec8529fffe84789d8c0505105d2ca86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ca0c29b1e04c783528f0ab0b69f0c5c62be8f5b8e8582d190436ddf17a63b24ffa8156d86e64d00a968bf2ac5a9cfdeff95cf596634ba86e3ec4bb08f8d5bca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-16 17:30:24.834976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:30:24.835312) ========= 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.m4CJmNrBDf/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.Lwt4yFW5GJ/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005146 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-16 17:30:24.884801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:30:24.885137) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-16 17:30:24.885565) ========= ========= Total master_lag: 10.81 =========