builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1459939812.33 results: success (0) buildid: 20160406012710 builduid: e5193389791d4425980868fbe87efb7a revision: 36519b1169034f298f1a0aeb460ff0af7637bbde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.327319) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.327709) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.328008) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005048 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.364262) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.364539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.379472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.379821) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005784 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.427417) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.427685) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.428023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.428312) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-06 03:50:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 138M=0s 2016-04-06 03:50:12 (138 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.574560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.574868) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.026781 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.622273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:12.622588) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 36519b1169034f298f1a0aeb460ff0af7637bbde --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 36519b1169034f298f1a0aeb460ff0af7637bbde --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-06 03:50:12,698 truncating revision to first 12 chars 2016-04-06 03:50:12,698 Setting DEBUG logging. 2016-04-06 03:50:12,698 attempt 1/10 2016-04-06 03:50:12,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/36519b116903?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 03:50:13,342 unpacking tar archive at: fx-team-36519b116903/testing/mozharness/ program finished with exit code 0 elapsedTime=0.894300 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:13.532807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:13.533187) ========= echo 36519b1169034f298f1a0aeb460ff0af7637bbde in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'36519b1169034f298f1a0aeb460ff0af7637bbde'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 36519b1169034f298f1a0aeb460ff0af7637bbde program finished with exit code 0 elapsedTime=0.005610 script_repo_revision: '36519b1169034f298f1a0aeb460ff0af7637bbde' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:13.582521) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:13.582829) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 03:50:13.595965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-06 03:50:13.596332) ========= /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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:13 INFO - MultiFileLogger online at 20160406 03:50:13 in /builds/slave/test 03:50: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 03:50:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:13 INFO - {'append_to_log': False, 03:50:13 INFO - 'base_work_dir': '/builds/slave/test', 03:50:13 INFO - 'blob_upload_branch': 'Fx-Team', 03:50:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:13 INFO - 'branch': 'Fx-Team', 03:50:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:13 INFO - 'config_files': ('talos/mac_config.py',), 03:50:13 INFO - 'default_actions': ('clobber', 03:50:13 INFO - 'read-buildbot-config', 03:50:13 INFO - 'download-and-extract', 03:50:13 INFO - 'populate-webroot', 03:50:13 INFO - 'create-virtualenv', 03:50:13 INFO - 'install', 03:50:13 INFO - 'run-tests'), 03:50:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:13 INFO - 'download_minidump_stackwalk': True, 03:50:13 INFO - 'download_symbols': 'ondemand', 03:50:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:13 INFO - 'installer_path': 'installer.exe', 03:50:13 INFO - 'log_level': 'info', 03:50:13 INFO - 'log_name': 'talos', 03:50:13 INFO - 'log_to_console': True, 03:50:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:50:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:50:13 INFO - 'opt_config_files': (), 03:50:13 INFO - 'pip_index': False, 03:50:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:50:13 INFO - 'cmd': ('bash', 03:50:13 INFO - '-c', 03:50:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:50:13 INFO - 'enabled': True, 03:50:13 INFO - 'halt_on_failure': False, 03:50:13 INFO - 'name': 'check_screen_resolution'},), 03:50:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:50:13 INFO - 'cmd': ('bash', 03:50:13 INFO - '-c', 03:50:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:50:13 INFO - 'enabled': True, 03:50:13 INFO - 'halt_on_failure': False, 03:50:13 INFO - 'name': 'check_screen_resolution'},), 03:50:13 INFO - 'run_cmd_checks_enabled': True, 03:50:13 INFO - 'sps_profile': False, 03:50:13 INFO - 'sps_profile_interval': 0, 03:50:13 INFO - 'suite': 'dromaeojs', 03:50:13 INFO - 'system_bits': '32', 03:50:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:13 INFO - 'title': 't-yosemite-r7-0112', 03:50:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:13 INFO - 'use_talos_json': True, 03:50:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:13 INFO - 'work_dir': 'build'} 03:50:13 INFO - ##### 03:50:13 INFO - ##### Running clobber step. 03:50:13 INFO - ##### 03:50:13 INFO - Running pre-action listener: _resource_record_pre_action 03:50:13 INFO - Running main action method: clobber 03:50:13 INFO - rmtree: /builds/slave/test/build 03:50:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:15 INFO - Running post-action listener: _resource_record_post_action 03:50:15 INFO - ##### 03:50:15 INFO - ##### Running read-buildbot-config step. 03:50:15 INFO - ##### 03:50:15 INFO - Running pre-action listener: _resource_record_pre_action 03:50:15 INFO - Running main action method: read_buildbot_config 03:50:15 INFO - Using buildbot properties: 03:50:15 INFO - { 03:50:15 INFO - "project": "", 03:50:15 INFO - "product": "firefox", 03:50:15 INFO - "script_repo_revision": "production", 03:50:15 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:50:15 INFO - "repository": "", 03:50:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:50:15 INFO - "buildid": "20160406012710", 03:50:15 INFO - "pgo_build": "False", 03:50:15 INFO - "basedir": "/builds/slave/test", 03:50:15 INFO - "buildnumber": 616, 03:50:15 INFO - "slavename": "t-yosemite-r7-0112", 03:50:15 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:50:15 INFO - "platform": "yosemite_r7", 03:50:15 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:50:15 INFO - "branch": "fx-team", 03:50:15 INFO - "repo_path": "integration/fx-team", 03:50:15 INFO - "revision": "36519b1169034f298f1a0aeb460ff0af7637bbde", 03:50:15 INFO - "stage_platform": "macosx64", 03:50:15 INFO - "builduid": "e5193389791d4425980868fbe87efb7a", 03:50:15 INFO - "slavebuilddir": "test" 03:50:15 INFO - } 03:50:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:50:15 INFO - Running post-action listener: _resource_record_post_action 03:50:15 INFO - ##### 03:50:15 INFO - ##### Running download-and-extract step. 03:50:15 INFO - ##### 03:50:15 INFO - Running pre-action listener: _resource_record_pre_action 03:50:15 INFO - Running main action method: download_and_extract 03:50:15 INFO - mkdir: /builds/slave/test/build/tests 03:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:15 INFO - https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:50:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:50:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:50:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:16 INFO - Downloaded 1199 bytes. 03:50:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:50:16 INFO - Using the following test package requirements: 03:50:16 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:50:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:50:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:50:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'jsshell-mac.zip'], 03:50:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:50:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:50:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:50:16 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:50:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:50:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:50:16 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:50:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:50:16 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')]} 03:50:16 INFO - https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:50:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:50:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:50:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:17 INFO - Downloaded 17959966 bytes. 03:50:17 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'] 03:50:17 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 03:50:21 INFO - Return code: 0 03:50:21 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 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:21 INFO - https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:50:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:50:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:50:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:22 INFO - Downloaded 17959966 bytes. 03:50: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'] 03:50: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 03:50:25 INFO - Return code: 0 03:50: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')]} 03:50:25 INFO - https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:50:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:50:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:50:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:26 INFO - Downloaded 10847584 bytes. 03:50:26 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'] 03:50:26 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 03:50:26 INFO - Return code: 0 03:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:26 INFO - https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:50:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:50:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:50:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VPYHbh55Skim9l31KBMkJQ/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 03:50:29 INFO - Downloaded 111340918 bytes. 03:50:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:50:29 INFO - mkdir: /builds/slave/test/properties 03:50:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:29 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:29 INFO - Contents: 03:50:29 INFO - build_url:https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:50:30 INFO - Running post-action listener: _resource_record_post_action 03:50:30 INFO - Running post-action listener: set_extra_try_arguments 03:50:30 INFO - ##### 03:50:30 INFO - ##### Running populate-webroot step. 03:50:30 INFO - ##### 03:50:30 INFO - Running pre-action listener: _resource_record_pre_action 03:50:30 INFO - Running main action method: populate_webroot 03:50:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:30 INFO - '--tppagecycles', 03:50:30 INFO - '7'], 03:50:30 INFO - 'tests': ['tsvgm']}}, 03:50:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:50:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:50:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:50:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'tests': ['damp', 'tps']}, 03:50:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['damp', 'tps']}, 03:50:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:50:30 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['dromaeo_dom']}, 03:50:30 INFO - 'other': {'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'other_l64': {'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'other_nol64': {'tests': ['a11yr', 03:50:30 INFO - 'ts_paint', 03:50:30 INFO - 'tpaint', 03:50:30 INFO - 'sessionrestore', 03:50:30 INFO - 'sessionrestore_no_auto_restore', 03:50:30 INFO - 'tabpaint']}, 03:50:30 INFO - 'svgr': {'tests': ['tsvgx', 03:50:30 INFO - 'tsvgr_opacity', 03:50:30 INFO - 'tart', 03:50:30 INFO - 'tscrollx', 03:50:30 INFO - 'cart']}, 03:50:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['tsvgx', 03:50:30 INFO - 'tsvgr_opacity', 03:50:30 INFO - 'tart', 03:50:30 INFO - 'tscrollx', 03:50:30 INFO - 'cart']}, 03:50:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'tests': ['tp5o']}, 03:50:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'talos_options': ['--e10s'], 03:50:30 INFO - 'tests': ['tp5o']}, 03:50:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'talos_options': ['--xperf_path', 03:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:30 INFO - 'tests': ['tp5n']}, 03:50:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:50:30 INFO - 'talos_options': ['--e10s', 03:50:30 INFO - '--xperf_path', 03:50:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:30 INFO - 'tests': ['tp5n']}}, 03:50:30 INFO - 'talos.zip': {'path': '', 03:50:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:30 INFO - Running post-action listener: _resource_record_post_action 03:50:30 INFO - ##### 03:50:30 INFO - ##### Running create-virtualenv step. 03:50:30 INFO - ##### 03:50:30 INFO - Running pre-action listener: _resource_record_pre_action 03:50:30 INFO - Running main action method: create_virtualenv 03:50:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:30 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 03:50:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:31 INFO - Using real prefix '/tools/python27' 03:50:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:34 INFO - Installing pip.................done. 03:50:34 INFO - Return code: 0 03:50:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:34 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')]} 03:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:34 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')]} 03:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:34 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:34 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 03:50:34 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 03:50:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:34 INFO - 'HOME': '/Users/cltbld', 03:50:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:34 INFO - 'LOGNAME': 'cltbld', 03:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:34 INFO - 'MOZ_NO_REMOTE': '1', 03:50:34 INFO - 'NO_EM_RESTART': '1', 03:50:34 INFO - 'PAGER': '/bin/cat', 03:50:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:34 INFO - 'PWD': '/builds/slave/test', 03:50:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:34 INFO - 'SHELL': '/bin/bash', 03:50:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:34 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:34 INFO - 'USER': 'cltbld', 03:50:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:34 INFO - 'XPC_FLAGS': '0x0', 03:50:34 INFO - 'XPC_SERVICE_NAME': '0', 03:50:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:34 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 03:50:34 INFO - Cleaning up... 03:50:35 INFO - Return code: 0 03:50:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:50:35 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')]} 03:50:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:35 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')]} 03:50:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:35 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:35 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 03:50:35 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 03:50:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:35 INFO - 'HOME': '/Users/cltbld', 03:50:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:35 INFO - 'LOGNAME': 'cltbld', 03:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:35 INFO - 'MOZ_NO_REMOTE': '1', 03:50:35 INFO - 'NO_EM_RESTART': '1', 03:50:35 INFO - 'PAGER': '/bin/cat', 03:50:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:35 INFO - 'PWD': '/builds/slave/test', 03:50:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:35 INFO - 'SHELL': '/bin/bash', 03:50:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:35 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:35 INFO - 'USER': 'cltbld', 03:50:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:35 INFO - 'XPC_FLAGS': '0x0', 03:50:35 INFO - 'XPC_SERVICE_NAME': '0', 03:50:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:35 INFO - Downloading/unpacking psutil>=0.7.1 03:50:35 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 03:50:35 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 03:50:35 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 03:50:35 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 03:50:35 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 03:50:35 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 03:50:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:38 INFO - Installing collected packages: psutil 03:50:38 INFO - Running setup.py install for psutil 03:50:38 INFO - building 'psutil._psutil_osx' extension 03:50:38 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 03:50:38 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 03:50:38 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 03:50:39 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 03:50:39 INFO - building 'psutil._psutil_posix' extension 03:50:39 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 03:50:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:50:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:50:39 INFO - ^ 03:50:39 INFO - 1 warning generated. 03:50:39 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 03:50:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:39 INFO - Successfully installed psutil 03:50:39 INFO - Cleaning up... 03:50:39 INFO - Return code: 0 03:50:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:39 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:39 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 03:50:39 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 03:50:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:39 INFO - 'HOME': '/Users/cltbld', 03:50:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:39 INFO - 'LOGNAME': 'cltbld', 03:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:39 INFO - 'MOZ_NO_REMOTE': '1', 03:50:39 INFO - 'NO_EM_RESTART': '1', 03:50:39 INFO - 'PAGER': '/bin/cat', 03:50:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:39 INFO - 'PWD': '/builds/slave/test', 03:50:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:39 INFO - 'SHELL': '/bin/bash', 03:50:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:39 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:39 INFO - 'USER': 'cltbld', 03:50:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:39 INFO - 'XPC_FLAGS': '0x0', 03:50:39 INFO - 'XPC_SERVICE_NAME': '0', 03:50:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:50:39 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 03:50:39 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 03:50:39 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 03:50:39 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 03:50:39 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 03:50:39 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 03:50:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:50:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:50:42 INFO - Installing collected packages: mozsystemmonitor 03:50:42 INFO - Running setup.py install for mozsystemmonitor 03:50:42 INFO - Successfully installed mozsystemmonitor 03:50:42 INFO - Cleaning up... 03:50:42 INFO - Return code: 0 03:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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', '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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:50: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 blobuploader==1.2.4 03:50:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:42 INFO - 'HOME': '/Users/cltbld', 03:50:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:42 INFO - 'LOGNAME': 'cltbld', 03:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:42 INFO - 'MOZ_NO_REMOTE': '1', 03:50:42 INFO - 'NO_EM_RESTART': '1', 03:50:42 INFO - 'PAGER': '/bin/cat', 03:50:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:42 INFO - 'PWD': '/builds/slave/test', 03:50:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:42 INFO - 'SHELL': '/bin/bash', 03:50:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:42 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:42 INFO - 'USER': 'cltbld', 03:50:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:42 INFO - 'XPC_FLAGS': '0x0', 03:50:42 INFO - 'XPC_SERVICE_NAME': '0', 03:50:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:45 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 03:50:46 INFO - Downloading docopt-0.6.1.tar.gz 03:50:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:46 INFO - Running setup.py install for blobuploader 03:50:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:46 INFO - Running setup.py install for requests 03:50:46 INFO - Running setup.py install for docopt 03:50:47 INFO - Successfully installed blobuploader requests docopt 03:50:47 INFO - Cleaning up... 03:50:47 INFO - Return code: 0 03:50:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:47 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:47 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 03:50:47 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 03:50:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:47 INFO - 'HOME': '/Users/cltbld', 03:50:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:47 INFO - 'LOGNAME': 'cltbld', 03:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:47 INFO - 'MOZ_NO_REMOTE': '1', 03:50:47 INFO - 'NO_EM_RESTART': '1', 03:50:47 INFO - 'PAGER': '/bin/cat', 03:50:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:47 INFO - 'PWD': '/builds/slave/test', 03:50:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:47 INFO - 'SHELL': '/bin/bash', 03:50:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:47 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:47 INFO - 'USER': 'cltbld', 03:50:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:47 INFO - 'XPC_FLAGS': '0x0', 03:50:47 INFO - 'XPC_SERVICE_NAME': '0', 03:50:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eBe5in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FQ6BSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FZ8Fin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ViTXni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vGVtJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:47 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-6BZi9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-cuzKia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-8MVRUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-SNk5n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-PR0hey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-fIAhcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Miyllo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-W8jrhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Dkaaj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-brbYS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:48 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kf2i5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:49 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-C3O89j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:49 INFO - Running setup.py install for manifestparser 03:50:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:49 INFO - Running setup.py install for mozcrash 03:50:49 INFO - Running setup.py install for mozdebug 03:50:49 INFO - Running setup.py install for mozdevice 03:50:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:50:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:49 INFO - Running setup.py install for mozfile 03:50:49 INFO - Running setup.py install for mozhttpd 03:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozinfo 03:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozInstall 03:50:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozleak 03:50:50 INFO - Running setup.py install for mozlog 03:50:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for moznetwork 03:50:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozprocess 03:50:51 INFO - Running setup.py install for mozprofile 03:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Running setup.py install for mozrunner 03:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Running setup.py install for mozscreenshot 03:50:51 INFO - Running setup.py install for moztest 03:50:51 INFO - Running setup.py install for mozversion 03:50:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:51 INFO - Cleaning up... 03:50:51 INFO - Return code: 0 03:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:51 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')]} 03:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:51 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')]} 03:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:51 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:51 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 03:50:51 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 03:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:51 INFO - 'HOME': '/Users/cltbld', 03:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:51 INFO - 'LOGNAME': 'cltbld', 03:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:51 INFO - 'MOZ_NO_REMOTE': '1', 03:50:51 INFO - 'NO_EM_RESTART': '1', 03:50:51 INFO - 'PAGER': '/bin/cat', 03:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:51 INFO - 'PWD': '/builds/slave/test', 03:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:51 INFO - 'SHELL': '/bin/bash', 03:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:51 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:51 INFO - 'USER': 'cltbld', 03:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:51 INFO - 'XPC_FLAGS': '0x0', 03:50:51 INFO - 'XPC_SERVICE_NAME': '0', 03:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-h8V6R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-I7UHSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-LM5guD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3c1hcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4itI9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tn03tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-3PE3hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vm1Lut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:52 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)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:52 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-o_2GGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-jYdce_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-s7e0vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lbuwZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-pwdCrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tdaxKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-KetEbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-4W2d0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:53 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)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:53 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-ly_UB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:53 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)) 03:50:53 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)) 03:50:53 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)) 03:50:53 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)) 03:50:53 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)) 03:50:53 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)) 03:50:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:56 INFO - Downloading blessings-1.6.tar.gz 03:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:56 INFO - Installing collected packages: blessings 03:50:56 INFO - Running setup.py install for blessings 03:50:56 INFO - Successfully installed blessings 03:50:56 INFO - Cleaning up... 03:50:56 INFO - Return code: 0 03:50:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:56 INFO - Reading from file tmpfile_stdout 03:50:56 INFO - Current package versions: 03:50:56 INFO - blessings == 1.6 03:50:56 INFO - blobuploader == 1.2.4 03:50:56 INFO - docopt == 0.6.1 03:50:56 INFO - manifestparser == 1.1 03:50:56 INFO - mozInstall == 1.12 03:50:56 INFO - mozcrash == 0.17 03:50:56 INFO - mozdebug == 0.1 03:50:56 INFO - mozdevice == 0.48 03:50:56 INFO - mozfile == 1.2 03:50:56 INFO - mozhttpd == 0.7 03:50:56 INFO - mozinfo == 0.9 03:50:56 INFO - mozleak == 0.1 03:50:56 INFO - mozlog == 3.1 03:50:56 INFO - moznetwork == 0.27 03:50:56 INFO - mozprocess == 0.22 03:50:56 INFO - mozprofile == 0.28 03:50:56 INFO - mozrunner == 6.11 03:50:56 INFO - mozscreenshot == 0.1 03:50:56 INFO - mozsystemmonitor == 0.0 03:50:56 INFO - moztest == 0.7 03:50:56 INFO - mozversion == 1.4 03:50:56 INFO - psutil == 3.1.1 03:50:56 INFO - requests == 1.2.3 03:50:56 INFO - wsgiref == 0.1.2 03:50:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:56 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 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:56 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 03:50:56 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 03:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:56 INFO - 'HOME': '/Users/cltbld', 03:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:56 INFO - 'LOGNAME': 'cltbld', 03:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:56 INFO - 'MOZ_NO_REMOTE': '1', 03:50:56 INFO - 'NO_EM_RESTART': '1', 03:50:56 INFO - 'PAGER': '/bin/cat', 03:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:56 INFO - 'PWD': '/builds/slave/test', 03:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:56 INFO - 'SHELL': '/bin/bash', 03:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:56 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:56 INFO - 'USER': 'cltbld', 03:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:56 INFO - 'XPC_FLAGS': '0x0', 03:50:56 INFO - 'XPC_SERVICE_NAME': '0', 03:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 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)) 03:50:57 INFO - Cleaning up... 03:50:57 INFO - Return code: 0 03:50:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:50:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:50:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:57 INFO - 'HOME': '/Users/cltbld', 03:50:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:57 INFO - 'LOGNAME': 'cltbld', 03:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:57 INFO - 'MOZ_NO_REMOTE': '1', 03:50:57 INFO - 'NO_EM_RESTART': '1', 03:50:57 INFO - 'PAGER': '/bin/cat', 03:50:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:57 INFO - 'PWD': '/builds/slave/test', 03:50:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:57 INFO - 'SHELL': '/bin/bash', 03:50:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:50:57 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:50:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:57 INFO - 'USER': 'cltbld', 03:50:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:57 INFO - 'XPC_FLAGS': '0x0', 03:50:57 INFO - 'XPC_SERVICE_NAME': '0', 03:50:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:57 INFO - Downloading/unpacking jsonschema 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:59 INFO - Downloading/unpacking functools32 (from jsonschema) 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:51:00 INFO - warning: no files found matching '*.txt' 03:51:00 INFO - no previously-included directories found matching 'build' 03:51:00 INFO - no previously-included directories found matching 'dist' 03:51:00 INFO - no previously-included directories found matching '.git*' 03:51:00 INFO - Installing collected packages: jsonschema, functools32 03:51:00 INFO - Running setup.py install for functools32 03:51:00 INFO - warning: no files found matching '*.txt' 03:51:00 INFO - no previously-included directories found matching 'build' 03:51:00 INFO - no previously-included directories found matching 'dist' 03:51:00 INFO - no previously-included directories found matching '.git*' 03:51:00 INFO - Successfully installed jsonschema functools32 03:51:00 INFO - Cleaning up... 03:51:00 INFO - Return code: 0 03:51:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd7fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fd8f420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d3247cb70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, '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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 03:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:00 INFO - 'HOME': '/Users/cltbld', 03:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:00 INFO - 'LOGNAME': 'cltbld', 03:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:00 INFO - 'MOZ_NO_REMOTE': '1', 03:51:00 INFO - 'NO_EM_RESTART': '1', 03:51:00 INFO - 'PAGER': '/bin/cat', 03:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:00 INFO - 'PWD': '/builds/slave/test', 03:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:00 INFO - 'SHELL': '/bin/bash', 03:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:51:00 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:00 INFO - 'USER': 'cltbld', 03:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:00 INFO - 'XPC_FLAGS': '0x0', 03:51:00 INFO - 'XPC_SERVICE_NAME': '0', 03:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:51:00 INFO - Downloading/unpacking flake8 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:51:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:51:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:04 INFO - no previously-included directories found matching 'docs/_build' 03:51:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:51:04 INFO - Running setup.py install for pep8 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:51:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:51:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:51:04 INFO - no previously-included directories found matching 'docs/_build' 03:51:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:51:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:51:04 INFO - Cleaning up... 03:51:04 INFO - Return code: 0 03:51:04 INFO - Running post-action listener: _resource_record_post_action 03:51:04 INFO - Running post-action listener: _start_resource_monitoring 03:51:04 INFO - Starting resource monitoring. 03:51:04 INFO - ##### 03:51:04 INFO - ##### Running install step. 03:51:04 INFO - ##### 03:51:04 INFO - Running pre-action listener: _resource_record_pre_action 03:51:04 INFO - Running main action method: install 03:51:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:51:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:51:05 INFO - Reading from file tmpfile_stdout 03:51:05 INFO - Detecting whether we're running mozinstall >=1.0... 03:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:51:05 INFO - Reading from file tmpfile_stdout 03:51:05 INFO - Output received: 03:51:05 INFO - Usage: mozinstall [options] installer 03:51:05 INFO - Options: 03:51:05 INFO - -h, --help show this help message and exit 03:51:05 INFO - -d DEST, --destination=DEST 03:51:05 INFO - Directory to install application into. [default: 03:51:05 INFO - "/builds/slave/test"] 03:51:05 INFO - --app=APP Application being installed. [default: firefox] 03:51:05 INFO - mkdir: /builds/slave/test/build/application 03:51:05 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'] 03:51:05 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 03:51:39 INFO - Reading from file tmpfile_stdout 03:51:39 INFO - Output received: 03:51:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:51:39 INFO - Running post-action listener: _resource_record_post_action 03:51:39 INFO - ##### 03:51:39 INFO - ##### Running run-tests step. 03:51:39 INFO - ##### 03:51:39 INFO - Running pre-action listener: _resource_record_pre_action 03:51:39 INFO - Running main action method: run_tests 03:51:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:51:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:51:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:51:39 INFO - 2016-04-06 03:51:39.163 screenresolution[1641:7445] starting screenresolution argv=screenresolution get 03:51:39 INFO - 2016-04-06 03:51:39.165 screenresolution[1641:7445] Display 0: 1600x1200x32@60 03:51:39 INFO - 2016-04-06 03:51:39.171 screenresolution[1642:7447] starting screenresolution argv=screenresolution list 03:51:39 INFO - Available Modes on Display 0 03:51:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:51:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:51:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:51:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:51:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:51:39 INFO - Intel Iris: 03:51:39 INFO - Chipset Model: Intel Iris 03:51:39 INFO - Type: GPU 03:51:39 INFO - Bus: Built-In 03:51:39 INFO - VRAM (Dynamic, Max): 1536 MB 03:51:39 INFO - Vendor: Intel (0x8086) 03:51:39 INFO - Device ID: 0x0a2e 03:51:39 INFO - Revision ID: 0x0009 03:51:39 INFO - Displays: 03:51:39 INFO - Display: 03:51:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:51:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:51:39 INFO - Display Serial Number: 1600x1200 60 03:51:39 INFO - Main Display: Yes 03:51:39 INFO - Mirror: Off 03:51:39 INFO - Online: Yes 03:51:39 INFO - Rotation: Supported 03:51:39 INFO - Return code: 0 03:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:39 INFO - Python 2.7.3 03:51:39 INFO - Return code: 0 03:51:39 INFO - grabbing minidump binary from tooltool 03:51:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:51:39 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 0x10fc1ee00>, '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 0x10fa47db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc19b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:39 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 03:51:39 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 03:51:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:39 INFO - Return code: 0 03:51:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:51:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:51:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:51:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:51:40 INFO - Return code: 0 03:51:40 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/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 03:51:40 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/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 03:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7WZ8CjHq2b/Render', 03:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:40 INFO - 'HOME': '/Users/cltbld', 03:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:40 INFO - 'LOGNAME': 'cltbld', 03:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:40 INFO - 'MOZ_NO_REMOTE': '1', 03:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:40 INFO - 'NO_EM_RESTART': '1', 03:51:40 INFO - 'PAGER': '/bin/cat', 03:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:40 INFO - 'PWD': '/builds/slave/test', 03:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:40 INFO - 'SHELL': '/bin/bash', 03:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jqOj0le6ZB/Listeners', 03:51:40 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 03:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:40 INFO - 'USER': 'cltbld', 03:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:40 INFO - 'XPC_FLAGS': '0x0', 03:51:40 INFO - 'XPC_SERVICE_NAME': '0', 03:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:40 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/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 03:51:40 INFO - mozversion application_buildid: 20160406012710 03:51:40 INFO - mozversion application_changeset: 36519b1169034f298f1a0aeb460ff0af7637bbde 03:51:40 INFO - mozversion application_display_name: Nightly 03:51:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:40 INFO - mozversion application_name: Firefox 03:51:40 INFO - mozversion application_remotingname: firefox 03:51:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:51:40 INFO - mozversion application_vendor: Mozilla 03:51:40 INFO - mozversion application_version: 48.0a1 03:51:40 INFO - mozversion platform_buildid: 20160406012710 03:51:40 INFO - mozversion platform_changeset: 36519b1169034f298f1a0aeb460ff0af7637bbde 03:51:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:51:40 INFO - mozversion platform_version: 48.0a1 03:51:40 INFO - using testdate: 1459939900 03:51:40 INFO - actual date: 1459939900 03:51:40 INFO - starting webserver on 'localhost:49272' 03:51:40 INFO - SUITE-START | Running 2 tests 03:51:40 INFO - TEST-START | dromaeo_css 03:51:40 INFO - operating with platform_type : mac_ 03:51:40 INFO - Initialising browser for dromaeo_css test... 03:51:40 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpyLMT2O/profile http://localhost:49272/getInfo.html) 03:51:43 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 03:51:43 INFO - PROCESS | 1660 | colorDepth:24 03:51:43 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 03:51:43 INFO - PROCESS | 1660 | __metrics 03:51:43 INFO - PROCESS | 1660 | 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" 03:51:43 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:51:44 INFO - TEST-INFO | 1660: exit 0 03:51:44 INFO - Browser initialized. 03:51:44 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:44 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpyLMT2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:56 INFO - PROCESS | 1662 | RSS: Main: 235868160 03:51:56 INFO - PROCESS | 1662 | 03:52:47 INFO - PROCESS | 1662 | 1459939967503 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] 03:54:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 03:54:59 INFO - PROCESS | 1662 | RSS: Main: 380784640 03:54:59 INFO - PROCESS | 1662 | 03:58:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 03:58:02 INFO - PROCESS | 1662 | RSS: Main: 364314624 03:58:02 INFO - PROCESS | 1662 | 04:01:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 04:01:04 INFO - PROCESS | 1662 | RSS: Main: 365080576 04:01:04 INFO - PROCESS | 1662 | 04:04:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 04:04:07 INFO - PROCESS | 1662 | RSS: Main: 325107712 04:04:07 INFO - PROCESS | 1662 | 04:07:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 04:07:11 INFO - PROCESS | 1662 | RSS: Main: 326328320 04:07:11 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 04:10:13 INFO - PROCESS | 1662 | RSS: Main: 385314816 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | __start_tp_report 04:10:13 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:10:13 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:10:13 INFO - PROCESS | 1662 | |i|pagename|runs| 04:10:13 INFO - PROCESS | 1662 | |0;dojo.html;2764.530029894918;3476.652334766522;3533.2933413317337;3540.6990405815504;3583.960651411091;5612.326520817497;5686.573506986977;5699.629524080932;5699.629524080932;5726.198332233485;5665.575081868866;5710.885782284352;5711.742971566279;5716.39977802331;5727.513161381277;4470.955290447103;5027.321311622939;5145.74271286436;5183.585313174955;5250.553702935236;5224.843254702346;5234.214867769846;5245.554127899133;5252.422233554306;5261.973690131563;5189.688618682872;5225.843224703246;5230.450802665722;5250.7112108834;5260.55285300748;5215.269862219292;5260.342457192851;5264.499872512105;5279.604029697788;5333.093374126369;5049.6212784041345;5080.923786143211;5161.612879034087;5193.610479214036;5199.038177937094;5219.556337711299;5566.582506312002;5595.916061259084;5631.521320687746;5662.292213473316;6222.160008398853;6248;6256.124142620037;6266.310705822356;6267.2165979252595;6181.598196117283;6220.626762394271;6246.87506249877;6261.092141639437;6266.905996410058;5549.750261238254;5677.886442271131;5678.4605462480995;5854.443827836349;5892.616979896293;6115.510759139258;6206.968965155145;6216.751329946842;6227.09707092469;6228.128062071313;6100.127044624488;6131.233595800525;6139.124180917401;6167.444929956326;6189.916764566273;6261.749530018839;6273.372662733781;6277;6280.371962803683;6291.276503202099;6225.8132256032395;6262.34245404226;6262.812115636538;6278.843028924222;6279.623222606659;6106.004536230211;6181.629102253879;6182.1345011698395;6280.309165991737;6300.432961033529;4861.319415281863;4869.561739443467;4877.341558889575;4882.658213924991;4930.654854160174;3725.9068523287133;4392.253316936129;4398.296272596369;4398.934015989763;4401.053773438726;5611;5627.184058311522;5702.344230413472;5706.4864162225595;5713.285839270091;6238.064290356483;6247.250329960434;6265.498760099181;6266.216722909637;6274.2784579773;5708.429157084342;5713.057345538023;5714.942850571524;5733.541316694655;5773.422657734277;5298.443663415286;5303.416624171338;5352.839414817562;5363.329583802025;5377.973110134424;6148.907766383508;6253.499720022478;6277.309495955533;6290.402411770874;6314.147590075281;6210.534209934363;6247.96876015617;6250;6259.467945224525;6261.9373806263175;6239.407256310643;6275.6548389839;6283.71723272463;6296.087067375296;6313.684315784284;6103.786367477117;6126.853582554517;6160.507159427325;6199.907001395073;6205.906911396423;6219.346968568416;6224.346443623354;6229.50163986889;6237.220347456568;6246.656433896179;5660.943390566042;6097.054956481752;6131.386861313833;6141.84645383869;6179.073139029181;5973.074173503114;6084.817455476343;6107.704691583656;6149.493374123368;6158.04550294705;6029.8191054268445;6038.275406951194;6044.939550604614;6054.515638748801;6061.909071363845;5992.64044157352;6173.382661733791;6176.567640265138;6191.4118158774845;6202.7208775606105;6000.849978750566;6068.9089663654195;6100.725467353891;6100.938990610037;6122.020476723703 04:10:13 INFO - PROCESS | 1662 | |1;ext.html;494.1130670446548;575.6689903305601;579.8811243695043;619.3342157181031;639.0669622351368;30656;39189.60810391895;39269.41095883564;39355.212895742065;39486.80256598713;42346;43087.70736877891;43105.706828795184;43145.35281970765;43153.78423107888;9404.67083652074;9661.951690241574;9666.613335466607;9684.661036863712;9686.128248457637;9483.573239204252;9653.469059201741;9661;9664.468454235015;9666.130048295652;9568.138867501924;9758.951205243964;9769;9780.462074585896;9802.460864652441;9680.661176858812;9769;9777.706668799947;9795.90204097957;9808.21534277256;8238.423310368276;9515.048495150499;9675.516224188832;9689;9698.563564639608;41076.58923410787;41504.58495415037;41541;41550.58449415497;41693;3446.827658617059;3456.084137703511;3460.463628137643;3829.80850957451;3888.1640447303967;28388.432231355462;28713.856430717922;29282.853585732148;29378.70621293781;29514.70485295141;2380.4643955109964;2724.645796046521;2762.7237276272413;2832.3344014156655;2864.0834932821504;466651;469446;472917;474190;475213.62393188156;67940.6602966982;69343.65328173326;69379;69530.30469695339;69641.3035869645;73675.63162184154;73789;73812.2618773816;73852;73955.63022184855;17101.828981710274;17291.567710807078;17309;17326.653466930842;17348.566285842953;12758.298293593942;12782.936085319514;12789.104762666524;12799.936000319938;12831.935840320739;19653.31213407524;21281.68077478839;21640.619531851484;21722.34832955014;21779.23772667949;7610.39116870649;8995.505247211335;9072.591733372014;9234.815303694022;9239.584218710173;945.5461378538203;967.8257913575483;994.8656931314325;1064.9307794993301;1081.5133190064503;23735.98244149232;29147.562786558217;29389.706102939126;29768.10695679133;29911.700882990892;909.7316291693966;1091.7598128411737;1146.2033886448837;1150.8906653867868;1196.946137423818;14756.188409637572;14829.555113346616;15051;15115.773263401057;15154.318055687521;486492;489344;490168;490943;491384;58684;59382.406175937685;59459.70270148622;59467.161276453764;59853;1236.295311672356;1399.6920677450944;1432.2838580709645;1453.19347761991;1463.165995382643;28515.28711782222;28760.856195718887;29434.705652943197;29553.26116847096;29841.55237671393;47986.28020579624;48405.15948405131;48471.75764121157;48557.514424856716;48613;283154.58422707755;289530;289885;290030;290531;33651.83174084114;33771.66228337685;33975;33980.73298638715;34054.31891362208;44746.77626611846;45033.6209431808;45609.543904561855;45621;45631;36605.90182294536;36786.08034799151;36950;37608.811955940044;37758;36868.63131368759;37013.25973480461;37335;37464.812675936446;37489.625103749706;36472.90581282566;36857.81571092128;37120.07199819918;37798.62201377951;37834.43248351222;32358.041287085893;34757.758027351025;34988.825055875575;35438.64561354354;35512.46731298981;24392.146274880295;24459.143929962367;24595.385115372257;25100.99596016139;25216.495670086864 04:10:13 INFO - PROCESS | 1662 | |2;jquery.html;353.97700645135546;357.47451246667396;360.98736544220947;365.38615126587325;367.700324235748;16071.437499687529;17320.393786217468;18925.24299028039;19563.217471301166;19631.803681963174;18293.7255941161;18880;19496.805031949676;19513.41459756206;19531.511712207168;5528.336599608043;5674.886502269952;5716.1711551824965;5732.22614946981;5735.569832262576;5666.688332141731;5703.31560212775;5762.769489220426;5768.653880767147;5775.3358363788075;5526.58550608706;5635.380108188096;5646.915296270559;5678.744456499447;5686.147077938322;5558.583106267006;5577.44225577441;5632.295963004624;5640.407757185478;5665.461781130786;4735.479097299294;4838.491958344358;4873.975630121862;4886.65793394459;4886.804527818883;24364.512709745704;24444.755552444425;24578.385540361454;24672.643004634738;24675.62986555203;2292.621717416624;2349.835511514195;2472.357187131359;2512.873737575344;2639.2741995951073;11204.495797689124;14413.207273599948;14523.854761452461;14560.344784484723;14670.633234169125;1458.3656109592362;1681.9243134058997;1682.1337011438995;1744.494096711952;1861.6462872054267;91289.1742165153;92535;92737.53631231868;92926;93195;8050.396220283385;8991.505467199368;9874.160696340892;10033.498325083863;10386.636467723594;12399.566015189606;12593.93703031479;12654.177478463871;12683;12700.936495317648;8334.416590838584;8338;8431;8482.745517634481;8516.659333626585;8702.521361325062;8705.825883482421;8723.912760872438;8809.207171354481;8831.425957312755;5856.531477481792;5973.1338955852025;5974.476508490307;5992.820215393545;6056.152138700585;1749.2390809997692;1765.5497848048922;1769.9911500442415;1772.7518147459366;1774.5120091974552;923.4459324405437;930.7673081729567;950.7670620697835;1016.9221422097295;1055.3456856748865;18748.593855460895;18808.247670093042;20117.396478105682;20206.393808185778;20694.275700350416;865.7879416638011;938.422815466622;954.9856752148723;964.7154089543601;1088.3415533602056;8401.70594029206;11073.003429691367;11228.494717737558;11229.606963756392;11265.324080555192;553303.4361735629;557422.8515429669;564218;572472;580050.0997494985;68747;92286.07713922909;92933;94541;96071;979.2704435195825;1025.2003437319051;1045.341434896026;1045.4406892312577;1048.5176818663347;17836.643267134325;17844.375446859296;18272.908635456737;18623.81376186275;18633.72049419287;47114.58656240318;47274;48038.519614804805;48410.27384589305;49206.507934921625;63062;64399.35600644121;64823;65075;66525.33474665192;7283.963580182277;7458.366038886756;7512.248775122444;7576.052993375828;7694.115176754744;11817;12216.877831221575;12393.318367489876;12476.625701228977;12588.622341329774;10493.160547156056;10577.153827693919;10597.841032384675;10636.468176591294;10750.569977200825;10361.896381036093;10782.406967616856;10838.187135964992;11008.119350451785;11266.098712102848;11022.50398732075;11094;11460.713482163013;11584.420778961186;11596.710082247673;6665.3001434850585;7852.84294314122;7904.920950790419;7933.127355990721;8045.557494337868;10101.848472272775;10926.562937482411;11186.776264474502;11208.215424920178;11255.887441125811 04:10:13 INFO - PROCESS | 1662 | |3;mootools.html;1578.3055455599538;1615.7899473068503;1872.9719054214181;1941.592265624219;1989.5125694204912;8582.48505089695;8624.870626940601;8787.340949428795;8803.867941980867;8836.690715824947;7336;7719.035120609924;7910.129885712567;8338.666453341859;8546.957265213665;2432.683751112353;2465.2234546118007;2465.7410971847967;2466.5930121529927;2483.428811373385;2411.144043864429;2484.4782595654933;2484.4906794107164;2488.713797913236;2489.7759201671847;2145.52798384356;2397.3886658901956;2464.112919349033;2467.0748469324003;2469.296250568588;2406.7833894949363;2439.1097249503982;2441.841280316774;2446.510697860417;2449.3141920262356;2126.606577783115;2455.1407007547396;2459.8770061496853;2459.9508009839883;2463.0147940823636;7426.777196684054;8823.647054117891;8834.469931804113;8838.292936565123;8853.734387968307;5304.734763261821;5352;5489.58828087895;5506.779728810843;5513.61404701671;3551.3074950384685;3663.377225871608;3702.2040261343673;3703.9444408333898;3707.388280933643;1026.7946410717886;1046.4140081554278;1070.11180720003;1079.881213066562;1085.5711993762498;11843.703907402298;11859.229150105215;11861.644150675493;11862.58480953171;11872.347020913847;4757.286407038971;4869.172240719086;4910.582600479;4924.1875090610365;4982.601391888713;8507.61715722794;9942.552585133686;10067.345622534513;10087.344322619007;10091.344062635904;5479.0411677957;5483.588730845203;5497.340319161726;5498.092814685532;5501.807436739695;4413.757243351646;4511.706739062016;4551.681382303207;4792.544708252711;4979.950200498021;3657.5062366580173;3807.4479200516325;3888.300105980951;3923.4507168996365;3931.4299426583557;1135.0352200629563;1293.4050336845157;1306.4643496166525;1308.6586249094564;1316.1905428161613;1173.4602083041896;1187.1333926233724;1190.0598527163618;1293.0560690695845;1390.8400533938727;8044.758657240292;8150.2664760171865;8163.959180204061;8209.79475513117;8240.464369815943;502.7662137106263;509.39636530711226;512.64627407089;513.2250302043941;525.6556955194354;6126.724297406628;6181.35095814933;6189.783357582463;6195.070739389038;6199.132121502993;9980.251481138943;10390.844137337946;10391.740206494898;10470.47647617616;10495.842562361571;8826.86759698605;9840.16358609512;10265.948670256601;10350.327228730108;10354.11989980845;7381.409487241115;8197.221263979913;8204.425690201628;8254.05078415978;8260.586970651444;7882.487638303492;7918.762437126896;7986.041674999037;8071;8264.628091736007;8224.465409748347;9209.723708288762;9546.52267386614;9557.474338911426;9602.711918642452;9626.807463850824;9930.006999300012;9934.503274836085;9963.003699629979;10087.940766219735;6269.62382257066;6799.762008329685;7015;7206.639668016683;7621.961890190735;8195.057568379712;8252.711155109542;8264.793380165544;8265.380096492907;8268.421210515447;7181.174164971095;7301.160366557701;7309.013283206699;7420.814479638052;7492.475526713078;7112.57324560528;7234.204237533972;7252.129744430702;7279.944408060695;7346.669399877125;7589.316961473494;7702.268284512962;7703.614819259126;7714.884276735966;7734.458587898793;6891.483138764713;6894.413974811997;6989.091418115612;6990.126234220723;7022.08712867324;7010.298970102949;7090.893636595559;7093.255208203271;7094.467914906506;7103.041089453064 04:10:13 INFO - PROCESS | 1662 | |4;prototype.html;316.70388187045114;322.7434189819094;328.08464384367613;328.2892537655975;331.68821307970506;6576.177977752787;6593.934060659392;6601.240857301412;6609.570377925444;6611;6546.574472659274;6588.439982601472;6593.472522198224;6595.8351041224;6608.768693095731;4192.035831758697;4440.689151759362;4618.515055919131;4753.215719406294;4878.292647566092;4325.956740432587;4466.687331886769;4704.553067458586;4738.69198502098;4761.238201887699;3987.7806720630356;4618.261078227484;4741.431028276595;4747.8338258160975;4747.928781068286;4732.2428411454;4747.311639812208;4752.691075080109;4754.976225118887;4760.547747963955;3955.3078211312904;4037.899052523681;4143.461350024508;4143.544210136913;4147.149834283995;6249.6875156242;6331.620102793847;6350.142730731338;6361.045843123522;6362.836635543891;5814.040683287252;5818.854528636775;5820.738066787005;5830.4461076197695;5837.708114594253;5702.201691763156;5815.476607105338;7041.119860017498;7058.752973632136;7069.081019467436;4679.953200467986;4691.976540117312;4699.835505757316;4706.964467817109;4715.905681886343;7142.464315176382;7521.473496855222;7542;7554.508956917783;7573.356264717506;3909.3158697227873;4573.108243892409;4633.166030114612;4636.466806317249;4653.557911998355;4710.905781884343;4712.52874712526;4712.670113092119;4713.245880659147;4727.101850648366;5610.887782244332;5613.522850557667;5624.831255062355;5628.831135065954;5631.746571404296;6751.45988320943;7114.964425177945;7120.608366539786;7126.429885609139;7132.1441427029085;1669.1487341455945;1693.6697344017798;1707.4365459398368;1708.0776380754503;1708.9743653845203;1097.8737445193906;1101.3226865477673;1118.8825173356681;1122.4331712485143;1122.5341483284346;6429.3570642936265;6587.604743715392;6616.735330586819;6687.398134167948;6691.866162676816;7142.107236595426;7210.242924492853;7296.3433291003;7342.816429589197;7351.22812104732;6698.4641228701585;6745;6748.595084294958;6754.425873800684;6761.729530818712;3131.6085489313837;3901.8244179011444;3906.121122747359;3907.492026036597;3915.941260881089;6211.844703882349;7432.368248698813;7718;7735.883961740578;7758.844823103506;6181.598196117238;7513.699452021858;7612.923870761221;7618.733344332922;7620.542767433972;7704.422168337397;7704.884426733492;7739.61301934901;7741.845163096819;7741.845163096819;7395.741149059757;7398.778036658909;7406.814829629302;7406.888896666446;7409.925900740924;5615.354234263112;7234.457415693739;7264.527805692613;7266;7273.3453989141235;7649.196834332315;7701.845963080819;7705.499142555716;7705.807354816175;7713.151553329017;4814.181589129927;4824.903501930012;4830.396200474941;4837.612990960785;4842.201036828884;7290.234525374972;7298.124225093023;7299.197088320387;7304.671289792079;7313;6772.93227067723;7058.047163633049;7095.0421693070775;7097.964510177416;7099.396551292992;7009.929900700928;7053.470989675898;7077.681504332214;7087.68105435267;7111.395531379684;6505.1135170799935;6886.48351373659;6906.620135892575;6917.896231556631;6921.792346229419;5696.943030569641;6197.287311959182;7041.084658994298;7065.964670176616;7079.539829911039;6604.570702904296;6669.166354205724;6928.099347084847;6929.7228110875;6950.687219075053 04:10:13 INFO - PROCESS | 1662 | |5;yui.html;737.6164394514852;739.2939742545869;750.3921823323109;753.1677496366518;803.9678412863484;14936.626584335398;15167.544973650794;15187.164705941168;15196.772048419283;15232.009919355234;13835.79246311306;14055.718885622282;14201.431942722278;14206.218657973808;14229.003969722098;740.1451323721084;753.2128925273103;908.8545832666791;913.0732306708696;920.1948295241664;926.7914719188196;934.1079269297838;934.6448349627132;935.8876934767837;940.7883226274103;963.4026903319951;969.4813274897931;971.6307803034837;971.7279161834698;972.8151651186288;766.5094339622646;946.3517490518948;960.6253561111172;966.9854952175723;972.8248915195262;724.9166345870187;724.9637518124073;726.0851327327553;726.3898325406684;726.7020521586124;15008.699826003418;15078.849211507853;15084.24578771057;15096.094234345974;15135.772963405558;12464;12499;12534.435950382163;12554.623361299176;12799.424025918855;9930.602775888956;9972.850407243897;9991.850122248172;10342.9482852586;10590.947045264724;3533.911652208715;3585.784852908808;3615.3311637347174;3702.407614781649;3735.2156047230114;79077.20922790756;79779;80046;80168;80762.59618701869;9387.765305867408;9426.62293508252;9478.146966773023;9800.26498012652;10036.197104231644;22178.001989910492;22208;22266.554668906854;22272.220472283392;22288.888555557118;7423.85152296951;7436.479446438806;7522.623868806647;7533.886991695129;7565.130010048805;4007.9599204007586;4013.8795836124964;4020.8190631421658;4044.838206471767;4261.403403523509;3487.9651203488147;3498.0904964709357;3533.975147207281;3546.343926373629;3548.503209550665;561.3628531616645;620.4509009526602;629.9811005669837;630.215381849591;646.3181343682367;473.9336492890998;575.4159528079003;593.970301484924;595.3629616310507;615.2616859768295;7600.239976002466;7940.1265860755275;7959.681612735541;8141.715039973573;8145.226203510657;421.9599138081877;535.4779090386842;591.9437653422918;614.920060392155;631.43486579512;3803.8478460861256;3819.52255968004;3837.6162383761402;3852.4221366795205;3898.532176138825;86874.56562717145;88229.67655485173;88599.55700221457;88716.55641721879;89150.55424722836;67091.3290867085;71561;73904;74348.51302974018;75123;50777.74611126921;65205.34794652087;66998.33001669921;67290.32709672938;68926.86438813688;8178.46839955401;8326.583670816313;8382.874256886029;8418.326533877398;8534.82930341402;44995;45828;46462.53537464582;47707.76146119247;48771.75614122049;59165.40834591599;67054;68595.3140468589;68658.65670671615;68872;10797.892021080002;10808.783824323313;10929.508172132431;11009.504572294105;11223.10215182767;11643.879455076034;11740.236884602473;12128.090393220367;12257.509699611915;12456.501739930301;8054.838903221786;10010.112225879437;10745.032947034804;10901.566006707862;12011.039116870455;10785;10894.618688346187;11099.334039957628;11596.826047609124;11667.183297169116;10849.240553161202;10965.945170274097;10971.396573188551;10981.780364392827;11483.94258028738;8327.875081873655;9260.722178334661;9517.00071492511;9596.95201523988;9831.606735730491;9375.765605859908;9530.618060381345;9585.376950498474;9605.37565058269;9605.423674579548 04:10:13 INFO - PROCESS | 1662 | __end_tp_report 04:10:13 INFO - PROCESS | 1662 | __start_cc_report 04:10:13 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1224 04:10:13 INFO - PROCESS | 1662 | __end_cc_report 04:10:13 INFO - PROCESS | 1662 | __startTimestamp1459941013879__endTimestamp 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:10:13 INFO - PROCESS | 1662 | Number of tests: 6 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5734.72 Median:6054.52 stddev:663.32 (11.0%) stddev-sans-first:623.09 04:10:13 INFO - PROCESS | 1662 | Values: 2764.5 3476.7 3533.3 3540.7 3584.0 5612.3 5686.6 5699.6 5699.6 5726.2 5665.6 5710.9 5711.7 5716.4 5727.5 4471.0 5027.3 5145.7 5183.6 5250.6 5224.8 5234.2 5245.6 5252.4 5262.0 5189.7 5225.8 5230.5 5250.7 5260.6 5215.3 5260.3 5264.5 5279.6 5333.1 5049.6 5080.9 5161.6 5193.6 5199.0 5219.6 5566.6 5595.9 5631.5 5662.3 6222.2 6248.0 6256.1 6266.3 6267.2 6181.6 6220.6 6246.9 6261.1 6266.9 5549.8 5677.9 5678.5 5854.4 5892.6 6115.5 6207.0 6216.8 6227.1 6228.1 6100.1 6131.2 6139.1 6167.4 6189.9 6261.7 6273.4 6277.0 6280.4 6291.3 6225.8 6262.3 6262.8 6278.8 6279.6 6106.0 6181.6 6182.1 6280.3 6300.4 4861.3 4869.6 4877.3 4882.7 4930.7 3725.9 4392.3 4398.3 4398.9 4401.1 5611.0 5627.2 5702.3 5706.5 5713.3 6238.1 6247.3 6265.5 6266.2 6274.3 5708.4 5713.1 5714.9 5733.5 5773.4 5298.4 5303.4 5352.8 5363.3 5378.0 6148.9 6253.5 6277.3 6290.4 6314.1 6210.5 6248.0 6250.0 6259.5 6261.9 6239.4 6275.7 6283.7 6296.1 6313.7 6103.8 6126.9 6160.5 6199.9 6205.9 6219.3 6224.3 6229.5 6237.2 6246.7 5660.9 6097.1 6131.4 6141.8 6179.1 5973.1 6084.8 6107.7 6149.5 6158.0 6029.8 6038.3 6044.9 6054.5 6061.9 5992.6 6173.4 6176.6 6191.4 6202.7 6000.8 6068.9 6100.7 6100.9 6122.0 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:58145.34 Median:3858.99 stddev:113150.21 (2932.1%) stddev-sans-first:113384.84 04:10:13 INFO - PROCESS | 1662 | Values: 494.1 575.7 579.9 619.3 639.1 30656.0 39189.6 39269.4 39355.2 39486.8 42346.0 43087.7 43105.7 43145.4 43153.8 9404.7 9662.0 9666.6 9684.7 9686.1 9483.6 9653.5 9661.0 9664.5 9666.1 9568.1 9759.0 9769.0 9780.5 9802.5 9680.7 9769.0 9777.7 9795.9 9808.2 8238.4 9515.0 9675.5 9689.0 9698.6 41076.6 41504.6 41541.0 41550.6 41693.0 3446.8 3456.1 3460.5 3829.8 3888.2 28388.4 28713.9 29282.9 29378.7 29514.7 2380.5 2724.6 2762.7 2832.3 2864.1 466651.0 469446.0 472917.0 474190.0 475213.6 67940.7 69343.7 69379.0 69530.3 69641.3 73675.6 73789.0 73812.3 73852.0 73955.6 17101.8 17291.6 17309.0 17326.7 17348.6 12758.3 12782.9 12789.1 12799.9 12831.9 19653.3 21281.7 21640.6 21722.3 21779.2 7610.4 8995.5 9072.6 9234.8 9239.6 945.5 967.8 994.9 1064.9 1081.5 23736.0 29147.6 29389.7 29768.1 29911.7 909.7 1091.8 1146.2 1150.9 1196.9 14756.2 14829.6 15051.0 15115.8 15154.3 486492.0 489344.0 490168.0 490943.0 491384.0 58684.0 59382.4 59459.7 59467.2 59853.0 1236.3 1399.7 1432.3 1453.2 1463.2 28515.3 28760.9 29434.7 29553.3 29841.6 47986.3 48405.2 48471.8 48557.5 48613.0 283154.6 289530.0 289885.0 290030.0 290531.0 33651.8 33771.7 33975.0 33980.7 34054.3 44746.8 45033.6 45609.5 45621.0 45631.0 36605.9 36786.1 36950.0 37608.8 37758.0 36868.6 37013.3 37335.0 37464.8 37489.6 36472.9 36857.8 37120.1 37798.6 37834.4 32358.0 34757.8 34988.8 35438.6 35512.5 24392.1 24459.1 24595.4 25101.0 25216.5 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:31594.12 Median:363.19 stddev:93160.12 (25650.7%) stddev-sans-first:93391.92 04:10:13 INFO - PROCESS | 1662 | Values: 354.0 357.5 361.0 365.4 367.7 16071.4 17320.4 18925.2 19563.2 19631.8 18293.7 18880.0 19496.8 19513.4 19531.5 5528.3 5674.9 5716.2 5732.2 5735.6 5666.7 5703.3 5762.8 5768.7 5775.3 5526.6 5635.4 5646.9 5678.7 5686.1 5558.6 5577.4 5632.3 5640.4 5665.5 4735.5 4838.5 4874.0 4886.7 4886.8 24364.5 24444.8 24578.4 24672.6 24675.6 2292.6 2349.8 2472.4 2512.9 2639.3 11204.5 14413.2 14523.9 14560.3 14670.6 1458.4 1681.9 1682.1 1744.5 1861.6 91289.2 92535.0 92737.5 92926.0 93195.0 8050.4 8991.5 9874.2 10033.5 10386.6 12399.6 12593.9 12654.2 12683.0 12700.9 8334.4 8338.0 8431.0 8482.7 8516.7 8702.5 8705.8 8723.9 8809.2 8831.4 5856.5 5973.1 5974.5 5992.8 6056.2 1749.2 1765.5 1770.0 1772.8 1774.5 923.4 930.8 950.8 1016.9 1055.3 18748.6 18808.2 20117.4 20206.4 20694.3 865.8 938.4 955.0 964.7 1088.3 8401.7 11073.0 11228.5 11229.6 11265.3 553303.4 557422.9 564218.0 572472.0 580050.1 68747.0 92286.1 92933.0 94541.0 96071.0 979.3 1025.2 1045.3 1045.4 1048.5 17836.6 17844.4 18272.9 18623.8 18633.7 47114.6 47274.0 48038.5 48410.3 49206.5 63062.0 64399.4 64823.0 65075.0 66525.3 7284.0 7458.4 7512.2 7576.1 7694.1 11817.0 12216.9 12393.3 12476.6 12588.6 10493.2 10577.2 10597.8 10636.5 10750.6 10361.9 10782.4 10838.2 11008.1 11266.1 11022.5 11094.0 11460.7 11584.4 11596.7 6665.3 7852.8 7904.9 7933.1 8045.6 10101.8 10926.6 11186.8 11208.2 11255.9 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5951.27 Median:5493.46 stddev:3127.02 (56.9%) stddev-sans-first:3118.52 04:10:13 INFO - PROCESS | 1662 | Values: 1578.3 1615.8 1873.0 1941.6 1989.5 8582.5 8624.9 8787.3 8803.9 8836.7 7336.0 7719.0 7910.1 8338.7 8547.0 2432.7 2465.2 2465.7 2466.6 2483.4 2411.1 2484.5 2484.5 2488.7 2489.8 2145.5 2397.4 2464.1 2467.1 2469.3 2406.8 2439.1 2441.8 2446.5 2449.3 2126.6 2455.1 2459.9 2460.0 2463.0 7426.8 8823.6 8834.5 8838.3 8853.7 5304.7 5352.0 5489.6 5506.8 5513.6 3551.3 3663.4 3702.2 3703.9 3707.4 1026.8 1046.4 1070.1 1079.9 1085.6 11843.7 11859.2 11861.6 11862.6 11872.3 4757.3 4869.2 4910.6 4924.2 4982.6 8507.6 9942.6 10067.3 10087.3 10091.3 5479.0 5483.6 5497.3 5498.1 5501.8 4413.8 4511.7 4551.7 4792.5 4980.0 3657.5 3807.4 3888.3 3923.5 3931.4 1135.0 1293.4 1306.5 1308.7 1316.2 1173.5 1187.1 1190.1 1293.1 1390.8 8044.8 8150.3 8164.0 8209.8 8240.5 502.8 509.4 512.6 513.2 525.7 6126.7 6181.4 6189.8 6195.1 6199.1 9980.3 10390.8 10391.7 10470.5 10495.8 8826.9 9840.2 10265.9 10350.3 10354.1 7381.4 8197.2 8204.4 8254.1 8260.6 7882.5 7918.8 7986.0 8071.0 8264.6 8224.5 9209.7 9546.5 9557.5 9602.7 9626.8 9930.0 9934.5 9963.0 10087.9 6269.6 6799.8 7015.0 7206.6 7622.0 8195.1 8252.7 8264.8 8265.4 8268.4 7181.2 7301.2 7309.0 7420.8 7492.5 7112.6 7234.2 7252.1 7279.9 7346.7 7589.3 7702.3 7703.6 7714.9 7734.5 6891.5 6894.4 6989.1 6990.1 7022.1 7010.3 7090.9 7093.3 7094.5 7103.0 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5747.56 Median:6581.89 stddev:1852.94 (28.2%) stddev-sans-first:1812.75 04:10:13 INFO - PROCESS | 1662 | Values: 316.7 322.7 328.1 328.3 331.7 6576.2 6593.9 6601.2 6609.6 6611.0 6546.6 6588.4 6593.5 6595.8 6608.8 4192.0 4440.7 4618.5 4753.2 4878.3 4326.0 4466.7 4704.6 4738.7 4761.2 3987.8 4618.3 4741.4 4747.8 4747.9 4732.2 4747.3 4752.7 4755.0 4760.5 3955.3 4037.9 4143.5 4143.5 4147.1 6249.7 6331.6 6350.1 6361.0 6362.8 5814.0 5818.9 5820.7 5830.4 5837.7 5702.2 5815.5 7041.1 7058.8 7069.1 4680.0 4692.0 4699.8 4707.0 4715.9 7142.5 7521.5 7542.0 7554.5 7573.4 3909.3 4573.1 4633.2 4636.5 4653.6 4710.9 4712.5 4712.7 4713.2 4727.1 5610.9 5613.5 5624.8 5628.8 5631.7 6751.5 7115.0 7120.6 7126.4 7132.1 1669.1 1693.7 1707.4 1708.1 1709.0 1097.9 1101.3 1118.9 1122.4 1122.5 6429.4 6587.6 6616.7 6687.4 6691.9 7142.1 7210.2 7296.3 7342.8 7351.2 6698.5 6745.0 6748.6 6754.4 6761.7 3131.6 3901.8 3906.1 3907.5 3915.9 6211.8 7432.4 7718.0 7735.9 7758.8 6181.6 7513.7 7612.9 7618.7 7620.5 7704.4 7704.9 7739.6 7741.8 7741.8 7395.7 7398.8 7406.8 7406.9 7409.9 5615.4 7234.5 7264.5 7266.0 7273.3 7649.2 7701.8 7705.5 7705.8 7713.2 4814.2 4824.9 4830.4 4837.6 4842.2 7290.2 7298.1 7299.2 7304.7 7313.0 6772.9 7058.0 7095.0 7098.0 7099.4 7009.9 7053.5 7077.7 7087.7 7111.4 6505.1 6886.5 6906.6 6917.9 6921.8 5696.9 6197.3 7041.1 7066.0 7079.5 6604.6 6669.2 6928.1 6929.7 6950.7 04:10:13 INFO - PROCESS | 1662 | 04:10:13 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:17692.47 Median:630.10 stddev:24490.77 (3886.8%) stddev-sans-first:24526.38 04:10:13 INFO - PROCESS | 1662 | Values: 737.6 739.3 750.4 753.2 804.0 14936.6 15167.5 15187.2 15196.8 15232.0 13835.8 14055.7 14201.4 14206.2 14229.0 740.1 753.2 908.9 913.1 920.2 926.8 934.1 934.6 935.9 940.8 963.4 969.5 971.6 971.7 972.8 766.5 946.4 960.6 967.0 972.8 724.9 725.0 726.1 726.4 726.7 15008.7 15078.8 15084.2 15096.1 15135.8 12464.0 12499.0 12534.4 12554.6 12799.4 9930.6 9972.9 9991.9 10342.9 10590.9 3533.9 3585.8 3615.3 3702.4 3735.2 79077.2 79779.0 80046.0 80168.0 80762.6 9387.8 9426.6 9478.1 9800.3 10036.2 22178.0 22208.0 22266.6 22272.2 22288.9 7423.9 7436.5 7522.6 7533.9 7565.1 4008.0 4013.9 4020.8 4044.8 4261.4 3488.0 3498.1 3534.0 3546.3 3548.5 561.4 620.5 630.0 630.2 646.3 473.9 575.4 594.0 595.4 615.3 7600.2 7940.1 7959.7 8141.7 8145.2 422.0 535.5 591.9 614.9 631.4 3803.8 3819.5 3837.6 3852.4 3898.5 86874.6 88229.7 88599.6 88716.6 89150.6 67091.3 71561.0 73904.0 74348.5 75123.0 50777.7 65205.3 66998.3 67290.3 68926.9 8178.5 8326.6 8382.9 8418.3 8534.8 44995.0 45828.0 46462.5 47707.8 48771.8 59165.4 67054.0 68595.3 68658.7 68872.0 10797.9 10808.8 10929.5 11009.5 11223.1 11643.9 11740.2 12128.1 12257.5 12456.5 8054.8 10010.1 10745.0 10901.6 12011.0 10785.0 10894.6 11099.3 11596.8 11667.2 10849.2 10965.9 10971.4 10981.8 11483.9 8327.9 9260.7 9517.0 9597.0 9831.6 9375.8 9530.6 9585.4 9605.4 9605.4 04:10:13 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:10:13 INFO - PROCESS | 1662 | 04:10:14 INFO - TEST-INFO | 1662: exit 0 04:10:14 INFO - TEST-OK | dromaeo_css | took 1113371ms 04:10:14 INFO - TEST-START | kraken 04:10:14 INFO - operating with platform_type : mac_ 04:10:14 INFO - Initialising browser for kraken test... 04:10:14 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpjfDsfL/profile http://localhost:49272/getInfo.html) 04:10:16 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 04:10:16 INFO - PROCESS | 1675 | colorDepth:24 04:10:16 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 04:10:16 INFO - PROCESS | 1675 | __metrics 04:10:16 INFO - PROCESS | 1675 | 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" 04:10:16 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:10:17 INFO - TEST-INFO | 1675: exit 0 04:10:17 INFO - Browser initialized. 04:10:17 INFO - Running cycle 1/1 for kraken test... 04:10:17 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpjfDsfL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:29 INFO - PROCESS | 1677 | RSS: Main: 236154880 04:10:29 INFO - PROCESS | 1677 | 04:10:31 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:32 INFO - PROCESS | 1677 | RSS: Main: 281468928 04:10:32 INFO - PROCESS | 1677 | 04:10:34 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 04:10:35 INFO - PROCESS | 1677 | RSS: Main: 292003840 04:10:35 INFO - PROCESS | 1677 | 04:10:38 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 04:10:39 INFO - PROCESS | 1677 | RSS: Main: 276066304 04:10:39 INFO - PROCESS | 1677 | 04:10:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 04:10:42 INFO - PROCESS | 1677 | RSS: Main: 279478272 04:10:42 INFO - PROCESS | 1677 | 04:10:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:44 INFO - PROCESS | 1677 | RSS: Main: 279044096 04:10:44 INFO - PROCESS | 1677 | 04:10:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:48 INFO - PROCESS | 1677 | RSS: Main: 278966272 04:10:48 INFO - PROCESS | 1677 | 04:10:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:51 INFO - PROCESS | 1677 | RSS: Main: 279154688 04:10:51 INFO - PROCESS | 1677 | 04:10:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 04:10:54 INFO - PROCESS | 1677 | RSS: Main: 279511040 04:10:54 INFO - PROCESS | 1677 | 04:10:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:56 INFO - PROCESS | 1677 | RSS: Main: 314400768 04:10:56 INFO - PROCESS | 1677 | 04:10:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:59 INFO - PROCESS | 1677 | RSS: Main: 313970688 04:10:59 INFO - PROCESS | 1677 | 04:11:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:11:01 INFO - PROCESS | 1677 | RSS: Main: 321978368 04:11:01 INFO - PROCESS | 1677 | 04:11:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:11:05 INFO - PROCESS | 1677 | RSS: Main: 323235840 04:11:05 INFO - PROCESS | 1677 | 04:11:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:11:08 INFO - PROCESS | 1677 | RSS: Main: 324419584 04:11:08 INFO - PROCESS | 1677 | 04:11:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 04:11:10 INFO - PROCESS | 1677 | RSS: Main: 386273280 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | __start_tp_report 04:11:10 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 04:11:10 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 04:11:10 INFO - PROCESS | 1677 | |i|pagename|runs| 04:11:10 INFO - PROCESS | 1677 | |0;ai-astar;108;108;109;108;109;111;114;109;109;107 04:11:10 INFO - PROCESS | 1677 | |1;audio-beat-detection;156;123;140;158;144;172;170;143;161;119 04:11:10 INFO - PROCESS | 1677 | |2;audio-dft;185;222;230;186;185;184;182;185;180;182 04:11:10 INFO - PROCESS | 1677 | |3;audio-fft;80;73;84;85;76;84;82;87;82;64 04:11:10 INFO - PROCESS | 1677 | |4;audio-oscillator;91;94;122;79;77;81;111;78;78;116 04:11:10 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;88;85;88;85;91;85;89;86;88;85 04:11:10 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;94;94;93;94;94;94;94;116;87 04:11:10 INFO - PROCESS | 1677 | |7;imaging-desaturate;87;86;85;84;85;85;84;85;84;87 04:11:10 INFO - PROCESS | 1677 | |8;json-parse-financial;55;55;54;54;53;53;53;63;56;52 04:11:10 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;63;67;74;75;69;68;67;66;66;66 04:11:10 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;83;82;84;83;82;82;83;83;84;84 04:11:10 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;132;133;126;130;138;126;129;130;119;133 04:11:10 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;140;131;141;139;139;126;138;156;138;138 04:11:10 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;66;66;66;66;67;64;67;65;67;69 04:11:10 INFO - PROCESS | 1677 | __end_tp_report 04:11:10 INFO - PROCESS | 1677 | __start_cc_report 04:11:10 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1293 04:11:10 INFO - PROCESS | 1677 | __end_cc_report 04:11:10 INFO - PROCESS | 1677 | __startTimestamp1459941070233__endTimestamp 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | ------- Summary: start ------- 04:11:10 INFO - PROCESS | 1677 | Number of tests: 14 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:109.20 Median:109.00 stddev:1.99 (1.8%) stddev-sans-first:2.06 04:11:10 INFO - PROCESS | 1677 | Values: 108.0 108.0 109.0 108.0 109.0 111.0 114.0 109.0 109.0 107.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:157.00 stddev:18.14 (11.6%) stddev-sans-first:19.04 04:11:10 INFO - PROCESS | 1677 | Values: 156.0 123.0 140.0 158.0 144.0 172.0 170.0 143.0 161.0 119.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:192.10 Median:185.00 stddev:18.06 (9.8%) stddev-sans-first:18.97 04:11:10 INFO - PROCESS | 1677 | Values: 185.0 222.0 230.0 186.0 185.0 184.0 182.0 185.0 180.0 182.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:79.70 Median:83.00 stddev:6.95 (8.4%) stddev-sans-first:7.37 04:11:10 INFO - PROCESS | 1677 | Values: 80.0 73.0 84.0 85.0 76.0 84.0 82.0 87.0 82.0 64.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:78.50 stddev:17.46 (22.2%) stddev-sans-first:18.51 04:11:10 INFO - PROCESS | 1677 | Values: 91.0 94.0 122.0 79.0 77.0 81.0 111.0 78.0 78.0 116.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:88.00 stddev:2.11 (2.4%) stddev-sans-first:2.20 04:11:10 INFO - PROCESS | 1677 | Values: 88.0 85.0 88.0 85.0 91.0 85.0 89.0 86.0 88.0 85.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:94.00 stddev:7.59 (8.1%) stddev-sans-first:8.00 04:11:10 INFO - PROCESS | 1677 | Values: 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 116.0 87.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.14 (1.3%) stddev-sans-first:1.00 04:11:10 INFO - PROCESS | 1677 | Values: 87.0 86.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 87.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:3.12 (5.7%) stddev-sans-first:3.31 04:11:10 INFO - PROCESS | 1677 | Values: 55.0 55.0 54.0 54.0 53.0 53.0 53.0 63.0 56.0 52.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:67.50 stddev:3.73 (5.5%) stddev-sans-first:3.46 04:11:10 INFO - PROCESS | 1677 | Values: 63.0 67.0 74.0 75.0 69.0 68.0 67.0 66.0 66.0 66.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 04:11:10 INFO - PROCESS | 1677 | Values: 83.0 82.0 84.0 83.0 82.0 82.0 83.0 83.0 84.0 84.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:131.00 stddev:5.15 (3.9%) stddev-sans-first:5.39 04:11:10 INFO - PROCESS | 1677 | Values: 132.0 133.0 126.0 130.0 138.0 126.0 129.0 130.0 119.0 133.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.60 Median:139.00 stddev:7.66 (5.5%) stddev-sans-first:8.11 04:11:10 INFO - PROCESS | 1677 | Values: 140.0 131.0 141.0 139.0 139.0 126.0 138.0 156.0 138.0 138.0 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.34 (2.0%) stddev-sans-first:1.41 04:11:10 INFO - PROCESS | 1677 | Values: 66.0 66.0 66.0 66.0 67.0 64.0 67.0 65.0 67.0 69.0 04:11:10 INFO - PROCESS | 1677 | -------- Summary: end -------- 04:11:10 INFO - PROCESS | 1677 | 04:11:10 INFO - TEST-INFO | 1677: exit 0 04:11:10 INFO - TEST-OK | kraken | took 56564ms 04:11:10 INFO - SUITE-END | took 1169s 04:11:10 INFO - Completed test suite (00:19:29) 04:11:10 INFO - javascript benchmark 04:11:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2764.530029894918, 3476.652334766522, 3533.2933413317337, 3540.6990405815504, 3583.960651411091, 5612.326520817497, 5686.573506986977, 5699.629524080932, 5699.629524080932, 5726.198332233485, 5665.575081868866, 5710.885782284352, 5711.742971566279, 5716.39977802331, 5727.513161381277, 4470.955290447103, 5027.321311622939, 5145.74271286436, 5183.585313174955, 5250.553702935236, 5224.843254702346, 5234.214867769846, 5245.554127899133, 5252.422233554306, 5261.973690131563, 5189.688618682872, 5225.843224703246, 5230.450802665722, 5250.7112108834, 5260.55285300748, 5215.269862219292, 5260.342457192851, 5264.499872512105, 5279.604029697788, 5333.093374126369, 5049.6212784041345, 5080.923786143211, 5161.612879034087, 5193.610479214036, 5199.038177937094, 5219.556337711299, 5566.582506312002, 5595.916061259084, 5631.521320687746, 5662.292213473316, 6222.160008398853, 6248.0, 6256.124142620037, 6266.310705822356, 6267.2165979252595, 6181.598196117283, 6220.626762394271, 6246.87506249877, 6261.092141639437, 6266.905996410058, 5549.750261238254, 5677.886442271131, 5678.4605462480995, 5854.443827836349, 5892.616979896293, 6115.510759139258, 6206.968965155145, 6216.751329946842, 6227.09707092469, 6228.128062071313, 6100.127044624488, 6131.233595800525, 6139.124180917401, 6167.444929956326, 6189.916764566273, 6261.749530018839, 6273.372662733781, 6277.0, 6280.371962803683, 6291.276503202099, 6225.8132256032395, 6262.34245404226, 6262.812115636538, 6278.843028924222, 6279.623222606659, 6106.004536230211, 6181.629102253879, 6182.1345011698395, 6280.309165991737, 6300.432961033529, 4861.319415281863, 4869.561739443467, 4877.341558889575, 4882.658213924991, 4930.654854160174, 3725.9068523287133, 4392.253316936129, 4398.296272596369, 4398.934015989763, 4401.053773438726, 5611.0, 5627.184058311522, 5702.344230413472, 5706.4864162225595, 5713.285839270091, 6238.064290356483, 6247.250329960434, 6265.498760099181, 6266.216722909637, 6274.2784579773, 5708.429157084342, 5713.057345538023, 5714.942850571524, 5733.541316694655, 5773.422657734277, 5298.443663415286, 5303.416624171338, 5352.839414817562, 5363.329583802025, 5377.973110134424, 6148.907766383508, 6253.499720022478, 6277.309495955533, 6290.402411770874, 6314.147590075281, 6210.534209934363, 6247.96876015617, 6250.0, 6259.467945224525, 6261.9373806263175, 6239.407256310643, 6275.6548389839, 6283.71723272463, 6296.087067375296, 6313.684315784284, 6103.786367477117, 6126.853582554517, 6160.507159427325, 6199.907001395073, 6205.906911396423, 6219.346968568416, 6224.346443623354, 6229.50163986889, 6237.220347456568, 6246.656433896179, 5660.943390566042, 6097.054956481752, 6131.386861313833, 6141.84645383869, 6179.073139029181, 5973.074173503114, 6084.817455476343, 6107.704691583656, 6149.493374123368, 6158.04550294705, 6029.8191054268445, 6038.275406951194, 6044.939550604614, 6054.515638748801, 6061.909071363845, 5992.64044157352, 6173.382661733791, 6176.567640265138, 6191.4118158774845, 6202.7208775606105, 6000.849978750566, 6068.9089663654195, 6100.725467353891, 6100.938990610037, 6122.020476723703], "unit": "score", "name": "dojo.html", "value": 5690.638543952407}, {"lowerIsBetter": false, "replicates": [494.1130670446548, 575.6689903305601, 579.8811243695043, 619.3342157181031, 639.0669622351368, 30656.0, 39189.60810391895, 39269.41095883564, 39355.212895742065, 39486.80256598713, 42346.0, 43087.70736877891, 43105.706828795184, 43145.35281970765, 43153.78423107888, 9404.67083652074, 9661.951690241574, 9666.613335466607, 9684.661036863712, 9686.128248457637, 9483.573239204252, 9653.469059201741, 9661.0, 9664.468454235015, 9666.130048295652, 9568.138867501924, 9758.951205243964, 9769.0, 9780.462074585896, 9802.460864652441, 9680.661176858812, 9769.0, 9777.706668799947, 9795.90204097957, 9808.21534277256, 8238.423310368276, 9515.048495150499, 9675.516224188832, 9689.0, 9698.563564639608, 41076.58923410787, 41504.58495415037, 41541.0, 41550.58449415497, 41693.0, 3446.827658617059, 3456.084137703511, 3460.463628137643, 3829.80850957451, 3888.1640447303967, 28388.432231355462, 28713.856430717922, 29282.853585732148, 29378.70621293781, 29514.70485295141, 2380.4643955109964, 2724.645796046521, 2762.7237276272413, 2832.3344014156655, 2864.0834932821504, 466651.0, 469446.0, 472917.0, 474190.0, 475213.62393188156, 67940.6602966982, 69343.65328173326, 69379.0, 69530.30469695339, 69641.3035869645, 73675.63162184154, 73789.0, 73812.2618773816, 73852.0, 73955.63022184855, 17101.828981710274, 17291.567710807078, 17309.0, 17326.653466930842, 17348.566285842953, 12758.298293593942, 12782.936085319514, 12789.104762666524, 12799.936000319938, 12831.935840320739, 19653.31213407524, 21281.68077478839, 21640.619531851484, 21722.34832955014, 21779.23772667949, 7610.39116870649, 8995.505247211335, 9072.591733372014, 9234.815303694022, 9239.584218710173, 945.5461378538203, 967.8257913575483, 994.8656931314325, 1064.9307794993301, 1081.5133190064503, 23735.98244149232, 29147.562786558217, 29389.706102939126, 29768.10695679133, 29911.700882990892, 909.7316291693966, 1091.7598128411737, 1146.2033886448837, 1150.8906653867868, 1196.946137423818, 14756.188409637572, 14829.555113346616, 15051.0, 15115.773263401057, 15154.318055687521, 486492.0, 489344.0, 490168.0, 490943.0, 491384.0, 58684.0, 59382.406175937685, 59459.70270148622, 59467.161276453764, 59853.0, 1236.295311672356, 1399.6920677450944, 1432.2838580709645, 1453.19347761991, 1463.165995382643, 28515.28711782222, 28760.856195718887, 29434.705652943197, 29553.26116847096, 29841.55237671393, 47986.28020579624, 48405.15948405131, 48471.75764121157, 48557.514424856716, 48613.0, 283154.58422707755, 289530.0, 289885.0, 290030.0, 290531.0, 33651.83174084114, 33771.66228337685, 33975.0, 33980.73298638715, 34054.31891362208, 44746.77626611846, 45033.6209431808, 45609.543904561855, 45621.0, 45631.0, 36605.90182294536, 36786.08034799151, 36950.0, 37608.811955940044, 37758.0, 36868.63131368759, 37013.25973480461, 37335.0, 37464.812675936446, 37489.625103749706, 36472.90581282566, 36857.81571092128, 37120.07199819918, 37798.62201377951, 37834.43248351222, 32358.041287085893, 34757.758027351025, 34988.825055875575, 35438.64561354354, 35512.46731298981, 24392.146274880295, 24459.143929962367, 24595.385115372257, 25100.99596016139, 25216.495670086864], "unit": "score", "name": "ext.html", "value": 19809.260212205292}, {"lowerIsBetter": false, "replicates": [353.97700645135546, 357.47451246667396, 360.98736544220947, 365.38615126587325, 367.700324235748, 16071.437499687529, 17320.393786217468, 18925.24299028039, 19563.217471301166, 19631.803681963174, 18293.7255941161, 18880.0, 19496.805031949676, 19513.41459756206, 19531.511712207168, 5528.336599608043, 5674.886502269952, 5716.1711551824965, 5732.22614946981, 5735.569832262576, 5666.688332141731, 5703.31560212775, 5762.769489220426, 5768.653880767147, 5775.3358363788075, 5526.58550608706, 5635.380108188096, 5646.915296270559, 5678.744456499447, 5686.147077938322, 5558.583106267006, 5577.44225577441, 5632.295963004624, 5640.407757185478, 5665.461781130786, 4735.479097299294, 4838.491958344358, 4873.975630121862, 4886.65793394459, 4886.804527818883, 24364.512709745704, 24444.755552444425, 24578.385540361454, 24672.643004634738, 24675.62986555203, 2292.621717416624, 2349.835511514195, 2472.357187131359, 2512.873737575344, 2639.2741995951073, 11204.495797689124, 14413.207273599948, 14523.854761452461, 14560.344784484723, 14670.633234169125, 1458.3656109592362, 1681.9243134058997, 1682.1337011438995, 1744.494096711952, 1861.6462872054267, 91289.1742165153, 92535.0, 92737.53631231868, 92926.0, 93195.0, 8050.396220283385, 8991.505467199368, 9874.160696340892, 10033.498325083863, 10386.636467723594, 12399.566015189606, 12593.93703031479, 12654.177478463871, 12683.0, 12700.936495317648, 8334.416590838584, 8338.0, 8431.0, 8482.745517634481, 8516.659333626585, 8702.521361325062, 8705.825883482421, 8723.912760872438, 8809.207171354481, 8831.425957312755, 5856.531477481792, 5973.1338955852025, 5974.476508490307, 5992.820215393545, 6056.152138700585, 1749.2390809997692, 1765.5497848048922, 1769.9911500442415, 1772.7518147459366, 1774.5120091974552, 923.4459324405437, 930.7673081729567, 950.7670620697835, 1016.9221422097295, 1055.3456856748865, 18748.593855460895, 18808.247670093042, 20117.396478105682, 20206.393808185778, 20694.275700350416, 865.7879416638011, 938.422815466622, 954.9856752148723, 964.7154089543601, 1088.3415533602056, 8401.70594029206, 11073.003429691367, 11228.494717737558, 11229.606963756392, 11265.324080555192, 553303.4361735629, 557422.8515429669, 564218.0, 572472.0, 580050.0997494985, 68747.0, 92286.07713922909, 92933.0, 94541.0, 96071.0, 979.2704435195825, 1025.2003437319051, 1045.341434896026, 1045.4406892312577, 1048.5176818663347, 17836.643267134325, 17844.375446859296, 18272.908635456737, 18623.81376186275, 18633.72049419287, 47114.58656240318, 47274.0, 48038.519614804805, 48410.27384589305, 49206.507934921625, 63062.0, 64399.35600644121, 64823.0, 65075.0, 66525.33474665192, 7283.963580182277, 7458.366038886756, 7512.248775122444, 7576.052993375828, 7694.115176754744, 11817.0, 12216.877831221575, 12393.318367489876, 12476.625701228977, 12588.622341329774, 10493.160547156056, 10577.153827693919, 10597.841032384675, 10636.468176591294, 10750.569977200825, 10361.896381036093, 10782.406967616856, 10838.187135964992, 11008.119350451785, 11266.098712102848, 11022.50398732075, 11094.0, 11460.713482163013, 11584.420778961186, 11596.710082247673, 6665.3001434850585, 7852.84294314122, 7904.920950790419, 7933.127355990721, 8045.557494337868, 10101.848472272775, 10926.562937482411, 11186.776264474502, 11208.215424920178, 11255.887441125811], "unit": "score", "name": "jquery.html", "value": 9174.59662436199}, {"lowerIsBetter": false, "replicates": [1578.3055455599538, 1615.7899473068503, 1872.9719054214181, 1941.592265624219, 1989.5125694204912, 8582.48505089695, 8624.870626940601, 8787.340949428795, 8803.867941980867, 8836.690715824947, 7336.0, 7719.035120609924, 7910.129885712567, 8338.666453341859, 8546.957265213665, 2432.683751112353, 2465.2234546118007, 2465.7410971847967, 2466.5930121529927, 2483.428811373385, 2411.144043864429, 2484.4782595654933, 2484.4906794107164, 2488.713797913236, 2489.7759201671847, 2145.52798384356, 2397.3886658901956, 2464.112919349033, 2467.0748469324003, 2469.296250568588, 2406.7833894949363, 2439.1097249503982, 2441.841280316774, 2446.510697860417, 2449.3141920262356, 2126.606577783115, 2455.1407007547396, 2459.8770061496853, 2459.9508009839883, 2463.0147940823636, 7426.777196684054, 8823.647054117891, 8834.469931804113, 8838.292936565123, 8853.734387968307, 5304.734763261821, 5352.0, 5489.58828087895, 5506.779728810843, 5513.61404701671, 3551.3074950384685, 3663.377225871608, 3702.2040261343673, 3703.9444408333898, 3707.388280933643, 1026.7946410717886, 1046.4140081554278, 1070.11180720003, 1079.881213066562, 1085.5711993762498, 11843.703907402298, 11859.229150105215, 11861.644150675493, 11862.58480953171, 11872.347020913847, 4757.286407038971, 4869.172240719086, 4910.582600479, 4924.1875090610365, 4982.601391888713, 8507.61715722794, 9942.552585133686, 10067.345622534513, 10087.344322619007, 10091.344062635904, 5479.0411677957, 5483.588730845203, 5497.340319161726, 5498.092814685532, 5501.807436739695, 4413.757243351646, 4511.706739062016, 4551.681382303207, 4792.544708252711, 4979.950200498021, 3657.5062366580173, 3807.4479200516325, 3888.300105980951, 3923.4507168996365, 3931.4299426583557, 1135.0352200629563, 1293.4050336845157, 1306.4643496166525, 1308.6586249094564, 1316.1905428161613, 1173.4602083041896, 1187.1333926233724, 1190.0598527163618, 1293.0560690695845, 1390.8400533938727, 8044.758657240292, 8150.2664760171865, 8163.959180204061, 8209.79475513117, 8240.464369815943, 502.7662137106263, 509.39636530711226, 512.64627407089, 513.2250302043941, 525.6556955194354, 6126.724297406628, 6181.35095814933, 6189.783357582463, 6195.070739389038, 6199.132121502993, 9980.251481138943, 10390.844137337946, 10391.740206494898, 10470.47647617616, 10495.842562361571, 8826.86759698605, 9840.16358609512, 10265.948670256601, 10350.327228730108, 10354.11989980845, 7381.409487241115, 8197.221263979913, 8204.425690201628, 8254.05078415978, 8260.586970651444, 7882.487638303492, 7918.762437126896, 7986.041674999037, 8071.0, 8264.628091736007, 8224.465409748347, 9209.723708288762, 9546.52267386614, 9557.474338911426, 9602.711918642452, 9626.807463850824, 9930.006999300012, 9934.503274836085, 9963.003699629979, 10087.940766219735, 6269.62382257066, 6799.762008329685, 7015.0, 7206.639668016683, 7621.961890190735, 8195.057568379712, 8252.711155109542, 8264.793380165544, 8265.380096492907, 8268.421210515447, 7181.174164971095, 7301.160366557701, 7309.013283206699, 7420.814479638052, 7492.475526713078, 7112.57324560528, 7234.204237533972, 7252.129744430702, 7279.944408060695, 7346.669399877125, 7589.316961473494, 7702.268284512962, 7703.614819259126, 7714.884276735966, 7734.458587898793, 6891.483138764713, 6894.413974811997, 6989.091418115612, 6990.126234220723, 7022.08712867324, 7010.298970102949, 7090.893636595559, 7093.255208203271, 7094.467914906506, 7103.041089453064], "unit": "score", "name": "mootools.html", "value": 4789.072429847478}, {"lowerIsBetter": false, "replicates": [316.70388187045114, 322.7434189819094, 328.08464384367613, 328.2892537655975, 331.68821307970506, 6576.177977752787, 6593.934060659392, 6601.240857301412, 6609.570377925444, 6611.0, 6546.574472659274, 6588.439982601472, 6593.472522198224, 6595.8351041224, 6608.768693095731, 4192.035831758697, 4440.689151759362, 4618.515055919131, 4753.215719406294, 4878.292647566092, 4325.956740432587, 4466.687331886769, 4704.553067458586, 4738.69198502098, 4761.238201887699, 3987.7806720630356, 4618.261078227484, 4741.431028276595, 4747.8338258160975, 4747.928781068286, 4732.2428411454, 4747.311639812208, 4752.691075080109, 4754.976225118887, 4760.547747963955, 3955.3078211312904, 4037.899052523681, 4143.461350024508, 4143.544210136913, 4147.149834283995, 6249.6875156242, 6331.620102793847, 6350.142730731338, 6361.045843123522, 6362.836635543891, 5814.040683287252, 5818.854528636775, 5820.738066787005, 5830.4461076197695, 5837.708114594253, 5702.201691763156, 5815.476607105338, 7041.119860017498, 7058.752973632136, 7069.081019467436, 4679.953200467986, 4691.976540117312, 4699.835505757316, 4706.964467817109, 4715.905681886343, 7142.464315176382, 7521.473496855222, 7542.0, 7554.508956917783, 7573.356264717506, 3909.3158697227873, 4573.108243892409, 4633.166030114612, 4636.466806317249, 4653.557911998355, 4710.905781884343, 4712.52874712526, 4712.670113092119, 4713.245880659147, 4727.101850648366, 5610.887782244332, 5613.522850557667, 5624.831255062355, 5628.831135065954, 5631.746571404296, 6751.45988320943, 7114.964425177945, 7120.608366539786, 7126.429885609139, 7132.1441427029085, 1669.1487341455945, 1693.6697344017798, 1707.4365459398368, 1708.0776380754503, 1708.9743653845203, 1097.8737445193906, 1101.3226865477673, 1118.8825173356681, 1122.4331712485143, 1122.5341483284346, 6429.3570642936265, 6587.604743715392, 6616.735330586819, 6687.398134167948, 6691.866162676816, 7142.107236595426, 7210.242924492853, 7296.3433291003, 7342.816429589197, 7351.22812104732, 6698.4641228701585, 6745.0, 6748.595084294958, 6754.425873800684, 6761.729530818712, 3131.6085489313837, 3901.8244179011444, 3906.121122747359, 3907.492026036597, 3915.941260881089, 6211.844703882349, 7432.368248698813, 7718.0, 7735.883961740578, 7758.844823103506, 6181.598196117238, 7513.699452021858, 7612.923870761221, 7618.733344332922, 7620.542767433972, 7704.422168337397, 7704.884426733492, 7739.61301934901, 7741.845163096819, 7741.845163096819, 7395.741149059757, 7398.778036658909, 7406.814829629302, 7406.888896666446, 7409.925900740924, 5615.354234263112, 7234.457415693739, 7264.527805692613, 7266.0, 7273.3453989141235, 7649.196834332315, 7701.845963080819, 7705.499142555716, 7705.807354816175, 7713.151553329017, 4814.181589129927, 4824.903501930012, 4830.396200474941, 4837.612990960785, 4842.201036828884, 7290.234525374972, 7298.124225093023, 7299.197088320387, 7304.671289792079, 7313.0, 6772.93227067723, 7058.047163633049, 7095.0421693070775, 7097.964510177416, 7099.396551292992, 7009.929900700928, 7053.470989675898, 7077.681504332214, 7087.68105435267, 7111.395531379684, 6505.1135170799935, 6886.48351373659, 6906.620135892575, 6917.896231556631, 6921.792346229419, 5696.943030569641, 6197.287311959182, 7041.084658994298, 7065.964670176616, 7079.539829911039, 6604.570702904296, 6669.166354205724, 6928.099347084847, 6929.7228110875, 6950.687219075053], "unit": "score", "name": "prototype.html", "value": 5135.523277606641}, {"lowerIsBetter": false, "replicates": [737.6164394514852, 739.2939742545869, 750.3921823323109, 753.1677496366518, 803.9678412863484, 14936.626584335398, 15167.544973650794, 15187.164705941168, 15196.772048419283, 15232.009919355234, 13835.79246311306, 14055.718885622282, 14201.431942722278, 14206.218657973808, 14229.003969722098, 740.1451323721084, 753.2128925273103, 908.8545832666791, 913.0732306708696, 920.1948295241664, 926.7914719188196, 934.1079269297838, 934.6448349627132, 935.8876934767837, 940.7883226274103, 963.4026903319951, 969.4813274897931, 971.6307803034837, 971.7279161834698, 972.8151651186288, 766.5094339622646, 946.3517490518948, 960.6253561111172, 966.9854952175723, 972.8248915195262, 724.9166345870187, 724.9637518124073, 726.0851327327553, 726.3898325406684, 726.7020521586124, 15008.699826003418, 15078.849211507853, 15084.24578771057, 15096.094234345974, 15135.772963405558, 12464.0, 12499.0, 12534.435950382163, 12554.623361299176, 12799.424025918855, 9930.602775888956, 9972.850407243897, 9991.850122248172, 10342.9482852586, 10590.947045264724, 3533.911652208715, 3585.784852908808, 3615.3311637347174, 3702.407614781649, 3735.2156047230114, 79077.20922790756, 79779.0, 80046.0, 80168.0, 80762.59618701869, 9387.765305867408, 9426.62293508252, 9478.146966773023, 9800.26498012652, 10036.197104231644, 22178.001989910492, 22208.0, 22266.554668906854, 22272.220472283392, 22288.888555557118, 7423.85152296951, 7436.479446438806, 7522.623868806647, 7533.886991695129, 7565.130010048805, 4007.9599204007586, 4013.8795836124964, 4020.8190631421658, 4044.838206471767, 4261.403403523509, 3487.9651203488147, 3498.0904964709357, 3533.975147207281, 3546.343926373629, 3548.503209550665, 561.3628531616645, 620.4509009526602, 629.9811005669837, 630.215381849591, 646.3181343682367, 473.9336492890998, 575.4159528079003, 593.970301484924, 595.3629616310507, 615.2616859768295, 7600.239976002466, 7940.1265860755275, 7959.681612735541, 8141.715039973573, 8145.226203510657, 421.9599138081877, 535.4779090386842, 591.9437653422918, 614.920060392155, 631.43486579512, 3803.8478460861256, 3819.52255968004, 3837.6162383761402, 3852.4221366795205, 3898.532176138825, 86874.56562717145, 88229.67655485173, 88599.55700221457, 88716.55641721879, 89150.55424722836, 67091.3290867085, 71561.0, 73904.0, 74348.51302974018, 75123.0, 50777.74611126921, 65205.34794652087, 66998.33001669921, 67290.32709672938, 68926.86438813688, 8178.46839955401, 8326.583670816313, 8382.874256886029, 8418.326533877398, 8534.82930341402, 44995.0, 45828.0, 46462.53537464582, 47707.76146119247, 48771.75614122049, 59165.40834591599, 67054.0, 68595.3140468589, 68658.65670671615, 68872.0, 10797.892021080002, 10808.783824323313, 10929.508172132431, 11009.504572294105, 11223.10215182767, 11643.879455076034, 11740.236884602473, 12128.090393220367, 12257.509699611915, 12456.501739930301, 8054.838903221786, 10010.112225879437, 10745.032947034804, 10901.566006707862, 12011.039116870455, 10785.0, 10894.618688346187, 11099.334039957628, 11596.826047609124, 11667.183297169116, 10849.240553161202, 10965.945170274097, 10971.396573188551, 10981.780364392827, 11483.94258028738, 8327.875081873655, 9260.722178334661, 9517.00071492511, 9596.95201523988, 9831.606735730491, 9375.765605859908, 9530.618060381345, 9585.376950498474, 9605.37565058269, 9605.423674579548], "unit": "score", "name": "yui.html", "value": 6820.159670260527}], "name": "dromaeo_css", "value": 7468.1622500730955}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 108.0, 109.0, 108.0, 109.0, 111.0, 114.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [156.0, 123.0, 140.0, 158.0, 144.0, 172.0, 170.0, 143.0, 161.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [185.0, 222.0, 230.0, 186.0, 185.0, 184.0, 182.0, 185.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 192.1}, {"lowerIsBetter": true, "replicates": [80.0, 73.0, 84.0, 85.0, 76.0, 84.0, 82.0, 87.0, 82.0, 64.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 122.0, 79.0, 77.0, 81.0, 111.0, 78.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 88.0, 85.0, 91.0, 85.0, 89.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 116.0, 87.0], "unit": "score", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 54.0, 53.0, 53.0, 53.0, 63.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 74.0, 75.0, 69.0, 68.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 83.0, 82.0, 82.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [132.0, 133.0, 126.0, 130.0, 138.0, 126.0, 129.0, 130.0, 119.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.6}, {"lowerIsBetter": true, "replicates": [140.0, 131.0, 141.0, 139.0, 139.0, 126.0, 138.0, 156.0, 138.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.6}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 64.0, 67.0, 65.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1430.1999999999998}]} 04:11:10 INFO - Return code: 0 04:11:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:11:11 ERROR - # TBPL SUCCESS # 04:11:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:11:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:11:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:11:11 INFO - 2016-04-06 04:11:11.046 screenresolution[1681:9632] starting screenresolution argv=screenresolution get 04:11:11 INFO - 2016-04-06 04:11:11.049 screenresolution[1681:9632] Display 0: 1600x1200x32@60 04:11:11 INFO - 2016-04-06 04:11:11.055 screenresolution[1682:9635] starting screenresolution argv=screenresolution list 04:11:11 INFO - Available Modes on Display 0 04:11:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:11:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:11:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:11:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:11:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:11:11 INFO - Intel Iris: 04:11:11 INFO - Chipset Model: Intel Iris 04:11:11 INFO - Type: GPU 04:11:11 INFO - Bus: Built-In 04:11:11 INFO - VRAM (Dynamic, Max): 1536 MB 04:11:11 INFO - Vendor: Intel (0x8086) 04:11:11 INFO - Device ID: 0x0a2e 04:11:11 INFO - Revision ID: 0x0009 04:11:11 INFO - Displays: 04:11:11 INFO - Display: 04:11:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:11:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:11:11 INFO - Display Serial Number: 1600x1200 60 04:11:11 INFO - Main Display: Yes 04:11:11 INFO - Mirror: Off 04:11:11 INFO - Online: Yes 04:11:11 INFO - Rotation: Supported 04:11:11 INFO - Return code: 0 04:11:11 INFO - Running post-action listener: _resource_record_post_action 04:11:11 INFO - Running post-run listener: _resource_record_post_run 04:11:12 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37713408; Write bytes: 701347328; Read time: 452; Write time: 2065 04:11:12 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 396954112; Write bytes: 390645248; Read time: 29848; Write time: 653 04:11:12 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35890688; Write bytes: 297385984; Read time: 431; Write time: 1378 04:11:12 INFO - Running post-run listener: _upload_blobber_files 04:11:12 INFO - Blob upload gear active. 04:11:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:11:12 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 04:11:12 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'] 04:11:12 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 04:11:13 INFO - (blobuploader) - INFO - Open directory for files ... 04:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:14 INFO - (blobuploader) - INFO - Done attempting. 04:11:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:11:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:11:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:11:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:16 INFO - (blobuploader) - INFO - Done attempting. 04:11:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:16 INFO - Return code: 0 04:11:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7a312b8d4faccd2b0ae9942e285f7560c88b4a3923eb8d7f5224da11527fe9d7392037948ca2b4963f072a98cfc3dfab05b62d99697f77e439296aabe5feef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9ff222b7ed414307e254874bfbc022865332269f121145824469d25491a752e4b88c9b86c0e29256130ab08301fc1ba3340e9dbec62dab966e28068244242d2"} 04:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:16 INFO - Contents: 04:11:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc7a312b8d4faccd2b0ae9942e285f7560c88b4a3923eb8d7f5224da11527fe9d7392037948ca2b4963f072a98cfc3dfab05b62d99697f77e439296aabe5feef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9ff222b7ed414307e254874bfbc022865332269f121145824469d25491a752e4b88c9b86c0e29256130ab08301fc1ba3340e9dbec62dab966e28068244242d2"} 04:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:16 INFO - Copying logs to upload dir... 04:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.080423 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-06 04:11:16.706836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:11:16.710343) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/cc7a312b8d4faccd2b0ae9942e285f7560c88b4a3923eb8d7f5224da11527fe9d7392037948ca2b4963f072a98cfc3dfab05b62d99697f77e439296aabe5feef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9ff222b7ed414307e254874bfbc022865332269f121145824469d25491a752e4b88c9b86c0e29256130ab08301fc1ba3340e9dbec62dab966e28068244242d2"} build_url:https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/VPYHbh55Skim9l31KBMkJQ/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/cc7a312b8d4faccd2b0ae9942e285f7560c88b4a3923eb8d7f5224da11527fe9d7392037948ca2b4963f072a98cfc3dfab05b62d99697f77e439296aabe5feef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b9ff222b7ed414307e254874bfbc022865332269f121145824469d25491a752e4b88c9b86c0e29256130ab08301fc1ba3340e9dbec62dab966e28068244242d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 04:11:16.737979) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:11:16.738308) ========= 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.7WZ8CjHq2b/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.jqOj0le6ZB/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005225 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 04:11:16.787959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:11:16.788275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 04:11:16.788674) ========= ========= Total master_lag: 0.26 =========