builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1459956856.61 results: success (0) buildid: 20160406064719 builduid: beaac92bd1074de99a4f4f62717032f0 revision: 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:16.605861) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:16.606293) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:16.606579) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005622 basedir: '/builds/slave/test' ========= master_lag: 0.67 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.284937) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.285213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.317658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.319154) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005604 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.372960) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.373262) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:17.373606) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 08:34:17.373880) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:17-- 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% 17.0M=0.001s 2016-04-06 08:34:17 (17.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.530989 ========= master_lag: 0.51 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 08:34:18.418373) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:18.418729) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.026287 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:18.550595) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 08:34:18.550961) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 --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 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:18,617 truncating revision to first 12 chars 2016-04-06 08:34:18,617 Setting DEBUG logging. 2016-04-06 08:34:18,617 attempt 1/10 2016-04-06 08:34:18,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/963e2caee42c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 08:34:20,201 unpacking tar archive at: fx-team-963e2caee42c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.887455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 08:34:20.460130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:20.460483) ========= echo 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 program finished with exit code 0 elapsedTime=0.006013 script_repo_revision: '963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:20.523682) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:20.524004) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 08:34:20.564140) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-06 08:34:20.564524) ========= /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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:20 INFO - MultiFileLogger online at 20160406 08:34:20 in /builds/slave/test 08:34:20 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 08:34:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:34:20 INFO - {'append_to_log': False, 08:34:20 INFO - 'base_work_dir': '/builds/slave/test', 08:34:20 INFO - 'blob_upload_branch': 'Fx-Team', 08:34:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:34:20 INFO - 'branch': 'Fx-Team', 08:34:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:34:20 INFO - 'config_files': ('talos/mac_config.py',), 08:34:20 INFO - 'default_actions': ('clobber', 08:34:20 INFO - 'read-buildbot-config', 08:34:20 INFO - 'download-and-extract', 08:34:20 INFO - 'populate-webroot', 08:34:20 INFO - 'create-virtualenv', 08:34:20 INFO - 'install', 08:34:20 INFO - 'run-tests'), 08:34:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:34:20 INFO - 'download_minidump_stackwalk': True, 08:34:20 INFO - 'download_symbols': 'ondemand', 08:34:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:34:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:34:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:34:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:34:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:34:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:34:20 INFO - 'installer_path': 'installer.exe', 08:34:20 INFO - 'log_level': 'info', 08:34:20 INFO - 'log_name': 'talos', 08:34:20 INFO - 'log_to_console': True, 08:34:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:34:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:34:20 INFO - 'opt_config_files': (), 08:34:20 INFO - 'pip_index': False, 08:34:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:20 INFO - 'cmd': ('bash', 08:34:20 INFO - '-c', 08:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:20 INFO - 'enabled': True, 08:34:20 INFO - 'halt_on_failure': False, 08:34:20 INFO - 'name': 'check_screen_resolution'},), 08:34:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:34:20 INFO - 'cmd': ('bash', 08:34:20 INFO - '-c', 08:34:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:34:20 INFO - 'enabled': True, 08:34:20 INFO - 'halt_on_failure': False, 08:34:20 INFO - 'name': 'check_screen_resolution'},), 08:34:20 INFO - 'run_cmd_checks_enabled': True, 08:34:20 INFO - 'sps_profile': False, 08:34:20 INFO - 'sps_profile_interval': 0, 08:34:20 INFO - 'suite': 'dromaeojs', 08:34:20 INFO - 'system_bits': '32', 08:34:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:34:20 INFO - 'title': 't-yosemite-r7-0038', 08:34:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:34:20 INFO - 'use_talos_json': True, 08:34:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:34:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:34:20 INFO - 'work_dir': 'build'} 08:34:20 INFO - ##### 08:34:20 INFO - ##### Running clobber step. 08:34:20 INFO - ##### 08:34:20 INFO - Running pre-action listener: _resource_record_pre_action 08:34:20 INFO - Running main action method: clobber 08:34:20 INFO - rmtree: /builds/slave/test/build 08:34:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:34:22 INFO - Running post-action listener: _resource_record_post_action 08:34:22 INFO - ##### 08:34:22 INFO - ##### Running read-buildbot-config step. 08:34:22 INFO - ##### 08:34:22 INFO - Running pre-action listener: _resource_record_pre_action 08:34:22 INFO - Running main action method: read_buildbot_config 08:34:22 INFO - Using buildbot properties: 08:34:22 INFO - { 08:34:22 INFO - "project": "", 08:34:22 INFO - "product": "firefox", 08:34:22 INFO - "script_repo_revision": "production", 08:34:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:34:22 INFO - "repository": "", 08:34:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:34:22 INFO - "buildid": "20160406064719", 08:34:22 INFO - "pgo_build": "False", 08:34:22 INFO - "basedir": "/builds/slave/test", 08:34:22 INFO - "buildnumber": 619, 08:34:22 INFO - "slavename": "t-yosemite-r7-0038", 08:34:22 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:34:22 INFO - "platform": "yosemite_r7", 08:34:22 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:34:22 INFO - "branch": "fx-team", 08:34:22 INFO - "repo_path": "integration/fx-team", 08:34:22 INFO - "revision": "963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7", 08:34:22 INFO - "stage_platform": "macosx64", 08:34:22 INFO - "builduid": "beaac92bd1074de99a4f4f62717032f0", 08:34:22 INFO - "slavebuilddir": "test" 08:34:22 INFO - } 08:34:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:34:22 INFO - Running post-action listener: _resource_record_post_action 08:34:22 INFO - ##### 08:34:22 INFO - ##### Running download-and-extract step. 08:34:22 INFO - ##### 08:34:22 INFO - Running pre-action listener: _resource_record_pre_action 08:34:22 INFO - Running main action method: download_and_extract 08:34:22 INFO - mkdir: /builds/slave/test/build/tests 08:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:22 INFO - https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:23 INFO - Downloaded 1199 bytes. 08:34:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:34:23 INFO - Using the following test package requirements: 08:34:23 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:34:23 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:34:23 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:34:23 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'jsshell-mac.zip'], 08:34:23 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:34:23 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:34:23 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:34:23 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:34:23 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:34:23 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:34:23 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:34:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:23 INFO - https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:34:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:34:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:34:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:25 INFO - Downloaded 17964271 bytes. 08:34:25 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'] 08:34:25 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 08:34:28 INFO - Return code: 0 08:34:28 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 08:34:28 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')]} 08:34:28 INFO - https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:34:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:34:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:34:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:30 INFO - Downloaded 17964271 bytes. 08:34:30 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'] 08:34:30 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 08:34:34 INFO - Return code: 0 08:34: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')]} 08:34:34 INFO - https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:34:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:34:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:34:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:36 INFO - Downloaded 10847617 bytes. 08:34:36 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'] 08:34:36 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 08:34:36 INFO - Return code: 0 08:34:36 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')]} 08:34:36 INFO - https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:34:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:34:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:34:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:34:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SdJea2A6Rv2X7CG-Av32yg/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 08:34:39 INFO - Downloaded 108920815 bytes. 08:34:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:34:39 INFO - mkdir: /builds/slave/test/properties 08:34:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:34:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:34:39 INFO - Contents: 08:34:39 INFO - build_url:https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:34:40 INFO - Running post-action listener: _resource_record_post_action 08:34:40 INFO - Running post-action listener: set_extra_try_arguments 08:34:40 INFO - ##### 08:34:40 INFO - ##### Running populate-webroot step. 08:34:40 INFO - ##### 08:34:40 INFO - Running pre-action listener: _resource_record_pre_action 08:34:40 INFO - Running main action method: populate_webroot 08:34:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:34:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:34:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:34:40 INFO - '--tppagecycles', 08:34:40 INFO - '7'], 08:34:40 INFO - 'tests': ['tsvgm']}}, 08:34:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:34:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:34:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:34:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:34:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:34:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['damp', 'tps']}, 08:34:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'tests': ['damp', 'tps']}, 08:34:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['dromaeo_dom']}, 08:34:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:34:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['a11yr', 08:34:40 INFO - 'ts_paint', 08:34:40 INFO - 'tpaint', 08:34:40 INFO - 'sessionrestore', 08:34:40 INFO - 'sessionrestore_no_auto_restore', 08:34:40 INFO - 'tabpaint']}, 08:34:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['tsvgx', 08:34:40 INFO - 'tsvgr_opacity', 08:34:40 INFO - 'tart', 08:34:40 INFO - 'tscrollx', 08:34:40 INFO - 'cart']}, 08:34:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:34:40 INFO - 'tsvgr_opacity', 08:34:40 INFO - 'tart', 08:34:40 INFO - 'tscrollx', 08:34:40 INFO - 'cart']}, 08:34:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'talos_options': ['--disable-e10s'], 08:34:40 INFO - 'tests': ['tp5o']}, 08:34:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'tests': ['tp5o']}, 08:34:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'talos_options': ['--disable-e10s', 08:34:40 INFO - '--xperf_path', 08:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:40 INFO - 'tests': ['tp5n']}, 08:34:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:34:40 INFO - 'talos_options': ['--xperf_path', 08:34:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:34:40 INFO - 'tests': ['tp5n']}}, 08:34:40 INFO - 'talos.zip': {'path': '', 08:34:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:34:40 INFO - Running post-action listener: _resource_record_post_action 08:34:40 INFO - ##### 08:34:40 INFO - ##### Running create-virtualenv step. 08:34:40 INFO - ##### 08:34:40 INFO - Running pre-action listener: _resource_record_pre_action 08:34:40 INFO - Running main action method: create_virtualenv 08:34:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:34:40 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 08:34:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:34:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:34:40 INFO - Using real prefix '/tools/python27' 08:34:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:34:41 INFO - Installing distribute.............................................................................................................................................................................................done. 08:34:43 INFO - Installing pip.................done. 08:34:43 INFO - Return code: 0 08:34:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:34:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:43 INFO - 'HOME': '/Users/cltbld', 08:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:43 INFO - 'LOGNAME': 'cltbld', 08:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:43 INFO - 'MOZ_NO_REMOTE': '1', 08:34:43 INFO - 'NO_EM_RESTART': '1', 08:34:43 INFO - 'PAGER': '/bin/cat', 08:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:43 INFO - 'PWD': '/builds/slave/test', 08:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:43 INFO - 'SHELL': '/bin/bash', 08:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:34:43 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:43 INFO - 'USER': 'cltbld', 08:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:43 INFO - 'XPC_FLAGS': '0x0', 08:34:43 INFO - 'XPC_SERVICE_NAME': '0', 08:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:44 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 08:34:44 INFO - Cleaning up... 08:34:44 INFO - Return code: 0 08:34:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:34:44 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')]} 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:44 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')]} 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:44 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:44 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 08:34:44 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 08:34:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:34:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:44 INFO - 'HOME': '/Users/cltbld', 08:34:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:44 INFO - 'LOGNAME': 'cltbld', 08:34:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:44 INFO - 'MOZ_NO_REMOTE': '1', 08:34:44 INFO - 'NO_EM_RESTART': '1', 08:34:44 INFO - 'PAGER': '/bin/cat', 08:34:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:44 INFO - 'PWD': '/builds/slave/test', 08:34:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:44 INFO - 'SHELL': '/bin/bash', 08:34:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:34:44 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:34:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:44 INFO - 'USER': 'cltbld', 08:34:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:44 INFO - 'XPC_FLAGS': '0x0', 08:34:44 INFO - 'XPC_SERVICE_NAME': '0', 08:34:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:44 INFO - Downloading/unpacking psutil>=0.7.1 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:34:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:47 INFO - Installing collected packages: psutil 08:34:47 INFO - Running setup.py install for psutil 08:34:47 INFO - building 'psutil._psutil_osx' extension 08:34:47 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 08:34:48 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 08:34:48 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 08:34:48 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 08:34:48 INFO - building 'psutil._psutil_posix' extension 08:34:48 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 08:34:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:34:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:34:48 INFO - ^ 08:34:48 INFO - 1 warning generated. 08:34:48 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 08:34:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:34:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:34:48 INFO - Successfully installed psutil 08:34:48 INFO - Cleaning up... 08:34:48 INFO - Return code: 0 08:34:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:34:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:48 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:48 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 08:34:48 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 08:34:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:34:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:48 INFO - 'HOME': '/Users/cltbld', 08:34:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:48 INFO - 'LOGNAME': 'cltbld', 08:34:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:48 INFO - 'MOZ_NO_REMOTE': '1', 08:34:48 INFO - 'NO_EM_RESTART': '1', 08:34:48 INFO - 'PAGER': '/bin/cat', 08:34:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:48 INFO - 'PWD': '/builds/slave/test', 08:34:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:48 INFO - 'SHELL': '/bin/bash', 08:34:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:34:48 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:34:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:48 INFO - 'USER': 'cltbld', 08:34:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:48 INFO - 'XPC_FLAGS': '0x0', 08:34:48 INFO - 'XPC_SERVICE_NAME': '0', 08:34:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:49 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 08:34:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:34:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:34:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:34:51 INFO - Installing collected packages: mozsystemmonitor 08:34:51 INFO - Running setup.py install for mozsystemmonitor 08:34:51 INFO - Successfully installed mozsystemmonitor 08:34:51 INFO - Cleaning up... 08:34:51 INFO - Return code: 0 08:34:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:51 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:51 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 08:34:51 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 08:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:51 INFO - 'HOME': '/Users/cltbld', 08:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:51 INFO - 'LOGNAME': 'cltbld', 08:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:51 INFO - 'MOZ_NO_REMOTE': '1', 08:34:51 INFO - 'NO_EM_RESTART': '1', 08:34:51 INFO - 'PAGER': '/bin/cat', 08:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:51 INFO - 'PWD': '/builds/slave/test', 08:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:51 INFO - 'SHELL': '/bin/bash', 08:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:34:51 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:51 INFO - 'USER': 'cltbld', 08:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:51 INFO - 'XPC_FLAGS': '0x0', 08:34:51 INFO - 'XPC_SERVICE_NAME': '0', 08:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:51 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 08:34:54 INFO - Downloading blobuploader-1.2.4.tar.gz 08:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:34:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:34:54 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 08:34:54 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 08:34:54 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 08:34:54 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 08:34:54 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 08:34:54 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 08:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:34:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:34:55 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 08:34:55 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 08:34:55 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 08:34:55 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 08:34:55 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 08:34:55 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 08:34:55 INFO - Downloading docopt-0.6.1.tar.gz 08:34:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:34:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:34:55 INFO - Running setup.py install for blobuploader 08:34:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:34:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:34:55 INFO - Running setup.py install for requests 08:34:56 INFO - Running setup.py install for docopt 08:34:56 INFO - Successfully installed blobuploader requests docopt 08:34:56 INFO - Cleaning up... 08:34:56 INFO - Return code: 0 08:34:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:34: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')]} 08:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34: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')]} 08:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:34:56 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:34:56 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 08:34:56 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 08:34:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:34:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:56 INFO - 'HOME': '/Users/cltbld', 08:34:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:56 INFO - 'LOGNAME': 'cltbld', 08:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:56 INFO - 'MOZ_NO_REMOTE': '1', 08:34:56 INFO - 'NO_EM_RESTART': '1', 08:34:56 INFO - 'PAGER': '/bin/cat', 08:34:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:56 INFO - 'PWD': '/builds/slave/test', 08:34:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:56 INFO - 'SHELL': '/bin/bash', 08:34:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:34:56 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:34:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:56 INFO - 'USER': 'cltbld', 08:34:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:56 INFO - 'XPC_FLAGS': '0x0', 08:34:56 INFO - 'XPC_SERVICE_NAME': '0', 08:34:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:34:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-V1dOJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:34:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-ZyGolO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:34:56 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-8_RX2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-7Tuoqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kvqJYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-H2hTom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-1aXvaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-PP8nmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-a24zbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-46tPyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-tuTMI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-kI2Hcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:34:57 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-W9SkVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:34:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-dre1El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-agb6uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:34:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-iu9Trb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:34:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:34:58 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-NqwGG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:34:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:34:58 INFO - Running setup.py install for manifestparser 08:34:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:34:58 INFO - Running setup.py install for mozcrash 08:34:58 INFO - Running setup.py install for mozdebug 08:34:58 INFO - Running setup.py install for mozdevice 08:34:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Running setup.py install for mozfile 08:34:59 INFO - Running setup.py install for mozhttpd 08:34:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Running setup.py install for mozinfo 08:34:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Running setup.py install for mozInstall 08:34:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Running setup.py install for mozleak 08:34:59 INFO - Running setup.py install for mozlog 08:34:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:34:59 INFO - Running setup.py install for moznetwork 08:35:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:35:00 INFO - Running setup.py install for mozprocess 08:35:00 INFO - Running setup.py install for mozprofile 08:35:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:35:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:35:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:35:00 INFO - Running setup.py install for mozrunner 08:35:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:35:00 INFO - Running setup.py install for mozscreenshot 08:35:00 INFO - Running setup.py install for moztest 08:35:00 INFO - Running setup.py install for mozversion 08:35:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:35:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:35:01 INFO - Cleaning up... 08:35:01 INFO - Return code: 0 08:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:01 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:35:01 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 08:35:01 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 08:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:01 INFO - 'HOME': '/Users/cltbld', 08:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:01 INFO - 'LOGNAME': 'cltbld', 08:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:01 INFO - 'MOZ_NO_REMOTE': '1', 08:35:01 INFO - 'NO_EM_RESTART': '1', 08:35:01 INFO - 'PAGER': '/bin/cat', 08:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:01 INFO - 'PWD': '/builds/slave/test', 08:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:01 INFO - 'SHELL': '/bin/bash', 08:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:35:01 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:01 INFO - 'USER': 'cltbld', 08:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:01 INFO - 'XPC_FLAGS': '0x0', 08:35:01 INFO - 'XPC_SERVICE_NAME': '0', 08:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-_KDfVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-rY1YnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-wW0fz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-sVSrQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Ztu5MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-BbX7Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:35:01 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)) 08:35:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:35:01 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-AH2sAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-T5iN0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Gixo5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-6DZuh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-00meuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-xPwejl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-OoCe7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-9WD7Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-Q8pxk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-k24Io8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:35:02 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)) 08:35:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:35:02 INFO - Running setup.py (path:/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/pip-P_J3dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:35:03 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)) 08:35:03 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)) 08:35:03 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)) 08:35:03 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)) 08:35:03 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)) 08:35:03 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)) 08:35:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35: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 08:35:05 INFO - Downloading blessings-1.6.tar.gz 08:35:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:35:05 INFO - Installing collected packages: blessings 08:35:05 INFO - Running setup.py install for blessings 08:35:05 INFO - Successfully installed blessings 08:35:05 INFO - Cleaning up... 08:35:05 INFO - Return code: 0 08:35:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:35:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:06 INFO - Reading from file tmpfile_stdout 08:35:06 INFO - Current package versions: 08:35:06 INFO - blessings == 1.6 08:35:06 INFO - blobuploader == 1.2.4 08:35:06 INFO - docopt == 0.6.1 08:35:06 INFO - manifestparser == 1.1 08:35:06 INFO - mozInstall == 1.12 08:35:06 INFO - mozcrash == 0.17 08:35:06 INFO - mozdebug == 0.1 08:35:06 INFO - mozdevice == 0.48 08:35:06 INFO - mozfile == 1.2 08:35:06 INFO - mozhttpd == 0.7 08:35:06 INFO - mozinfo == 0.9 08:35:06 INFO - mozleak == 0.1 08:35:06 INFO - mozlog == 3.1 08:35:06 INFO - moznetwork == 0.27 08:35:06 INFO - mozprocess == 0.22 08:35:06 INFO - mozprofile == 0.28 08:35:06 INFO - mozrunner == 6.11 08:35:06 INFO - mozscreenshot == 0.1 08:35:06 INFO - mozsystemmonitor == 0.0 08:35:06 INFO - moztest == 0.7 08:35:06 INFO - mozversion == 1.4 08:35:06 INFO - psutil == 3.1.1 08:35:06 INFO - requests == 1.2.3 08:35:06 INFO - wsgiref == 0.1.2 08:35:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:06 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:35:06 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 08:35:06 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 08:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:06 INFO - 'HOME': '/Users/cltbld', 08:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:06 INFO - 'LOGNAME': 'cltbld', 08:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:06 INFO - 'MOZ_NO_REMOTE': '1', 08:35:06 INFO - 'NO_EM_RESTART': '1', 08:35:06 INFO - 'PAGER': '/bin/cat', 08:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:06 INFO - 'PWD': '/builds/slave/test', 08:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:06 INFO - 'SHELL': '/bin/bash', 08:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:35:06 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:06 INFO - 'USER': 'cltbld', 08:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:06 INFO - 'XPC_FLAGS': '0x0', 08:35:06 INFO - 'XPC_SERVICE_NAME': '0', 08:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 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)) 08:35:06 INFO - Cleaning up... 08:35:06 INFO - Return code: 0 08:35:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:35:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:35:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:35:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:35:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:06 INFO - 'HOME': '/Users/cltbld', 08:35:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:06 INFO - 'LOGNAME': 'cltbld', 08:35:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:06 INFO - 'MOZ_NO_REMOTE': '1', 08:35:06 INFO - 'NO_EM_RESTART': '1', 08:35:06 INFO - 'PAGER': '/bin/cat', 08:35:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:06 INFO - 'PWD': '/builds/slave/test', 08:35:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:06 INFO - 'SHELL': '/bin/bash', 08:35:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:35:06 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:35:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:06 INFO - 'USER': 'cltbld', 08:35:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:06 INFO - 'XPC_FLAGS': '0x0', 08:35:06 INFO - 'XPC_SERVICE_NAME': '0', 08:35:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:06 INFO - Downloading/unpacking jsonschema 08:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:35:09 INFO - Downloading/unpacking functools32 (from jsonschema) 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:35:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:35:09 INFO - warning: no files found matching '*.txt' 08:35:09 INFO - no previously-included directories found matching 'build' 08:35:09 INFO - no previously-included directories found matching 'dist' 08:35:09 INFO - no previously-included directories found matching '.git*' 08:35:09 INFO - Installing collected packages: jsonschema, functools32 08:35:09 INFO - Running setup.py install for functools32 08:35:09 INFO - warning: no files found matching '*.txt' 08:35:09 INFO - no previously-included directories found matching 'build' 08:35:09 INFO - no previously-included directories found matching 'dist' 08:35:09 INFO - no previously-included directories found matching '.git*' 08:35:09 INFO - Successfully installed jsonschema functools32 08:35:09 INFO - Cleaning up... 08:35:09 INFO - Return code: 0 08:35:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:35:09 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 0x109da0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109db0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa49b570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, '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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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 08:35:09 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 08:35:09 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 08:35:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:35:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:09 INFO - 'HOME': '/Users/cltbld', 08:35:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:09 INFO - 'LOGNAME': 'cltbld', 08:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:09 INFO - 'MOZ_NO_REMOTE': '1', 08:35:09 INFO - 'NO_EM_RESTART': '1', 08:35:09 INFO - 'PAGER': '/bin/cat', 08:35:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:09 INFO - 'PWD': '/builds/slave/test', 08:35:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:09 INFO - 'SHELL': '/bin/bash', 08:35:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:35:09 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:35:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:09 INFO - 'USER': 'cltbld', 08:35:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:09 INFO - 'XPC_FLAGS': '0x0', 08:35:09 INFO - 'XPC_SERVICE_NAME': '0', 08:35:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:35:10 INFO - Downloading/unpacking flake8 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:35:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:35:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:35:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:35:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:12 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 08:35:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:35:13 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 08:35:13 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 08:35:13 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 08:35:13 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 08:35:13 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 08:35:13 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 08:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:35:13 INFO - no previously-included directories found matching 'docs/_build' 08:35:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:35:13 INFO - Running setup.py install for pep8 08:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:35:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:35:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:35:13 INFO - no previously-included directories found matching 'docs/_build' 08:35:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:35:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:35:14 INFO - Cleaning up... 08:35:14 INFO - Return code: 0 08:35:14 INFO - Running post-action listener: _resource_record_post_action 08:35:14 INFO - Running post-action listener: _start_resource_monitoring 08:35:14 INFO - Starting resource monitoring. 08:35:14 INFO - ##### 08:35:14 INFO - ##### Running install step. 08:35:14 INFO - ##### 08:35:14 INFO - Running pre-action listener: _resource_record_pre_action 08:35:14 INFO - Running main action method: install 08:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:35:14 INFO - Reading from file tmpfile_stdout 08:35:14 INFO - Detecting whether we're running mozinstall >=1.0... 08:35:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:35:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:35:14 INFO - Reading from file tmpfile_stdout 08:35:14 INFO - Output received: 08:35:14 INFO - Usage: mozinstall [options] installer 08:35:14 INFO - Options: 08:35:14 INFO - -h, --help show this help message and exit 08:35:14 INFO - -d DEST, --destination=DEST 08:35:14 INFO - Directory to install application into. [default: 08:35:14 INFO - "/builds/slave/test"] 08:35:14 INFO - --app=APP Application being installed. [default: firefox] 08:35:14 INFO - mkdir: /builds/slave/test/build/application 08:35:14 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'] 08:35:14 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 08:35:47 INFO - Reading from file tmpfile_stdout 08:35:47 INFO - Output received: 08:35:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:35:47 INFO - Running post-action listener: _resource_record_post_action 08:35:47 INFO - ##### 08:35:47 INFO - ##### Running run-tests step. 08:35:47 INFO - ##### 08:35:47 INFO - Running pre-action listener: _resource_record_pre_action 08:35:47 INFO - Running main action method: run_tests 08:35:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:35:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:35:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:35:47 INFO - 2016-04-06 08:35:47.344 screenresolution[1640:7750] starting screenresolution argv=screenresolution get 08:35:47 INFO - 2016-04-06 08:35:47.347 screenresolution[1640:7750] Display 0: 1600x1200x32@60 08:35:47 INFO - 2016-04-06 08:35:47.353 screenresolution[1641:7752] starting screenresolution argv=screenresolution list 08:35:47 INFO - Available Modes on Display 0 08:35:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:35:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:35:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:35:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:35:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:35:47 INFO - Intel Iris: 08:35:47 INFO - Chipset Model: Intel Iris 08:35:47 INFO - Type: GPU 08:35:47 INFO - Bus: Built-In 08:35:47 INFO - VRAM (Dynamic, Max): 1536 MB 08:35:47 INFO - Vendor: Intel (0x8086) 08:35:47 INFO - Device ID: 0x0a2e 08:35:47 INFO - Revision ID: 0x0009 08:35:47 INFO - Displays: 08:35:47 INFO - Display: 08:35:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:35:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:35:47 INFO - Display Serial Number: 1600x1200 60 08:35:47 INFO - Main Display: Yes 08:35:47 INFO - Mirror: Off 08:35:47 INFO - Online: Yes 08:35:47 INFO - Rotation: Supported 08:35:47 INFO - Return code: 0 08:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:35:47 INFO - Python 2.7.3 08:35:47 INFO - Return code: 0 08:35:47 INFO - grabbing minidump binary from tooltool 08:35: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')]} 08:35:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109c3fe00>, '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 0x109a68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109c3ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:35:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:35:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:35:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:35:47 INFO - Return code: 0 08:35:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:35:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:35:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:35:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:35:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:35:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:35:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:35:48 INFO - Return code: 0 08:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 08:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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 08:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1RB5Mul1g4/Render', 08:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:35:48 INFO - 'HOME': '/Users/cltbld', 08:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:35:48 INFO - 'LOGNAME': 'cltbld', 08:35:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:35:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:35:48 INFO - 'MOZ_NO_REMOTE': '1', 08:35:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:35:48 INFO - 'NO_EM_RESTART': '1', 08:35:48 INFO - 'PAGER': '/bin/cat', 08:35:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:35:48 INFO - 'PWD': '/builds/slave/test', 08:35:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:35:48 INFO - 'SHELL': '/bin/bash', 08:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RwnVXTBq1H/Listeners', 08:35:48 INFO - 'TMPDIR': '/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/', 08:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:35:48 INFO - 'USER': 'cltbld', 08:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:35:48 INFO - 'XPC_FLAGS': '0x0', 08:35:48 INFO - 'XPC_SERVICE_NAME': '0', 08:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:35:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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 08:35:49 INFO - mozversion application_buildid: 20160406064719 08:35:49 INFO - mozversion application_changeset: 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 08:35:49 INFO - mozversion application_display_name: Nightly 08:35:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:35:49 INFO - mozversion application_name: Firefox 08:35:49 INFO - mozversion application_remotingname: firefox 08:35:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:35:49 INFO - mozversion application_vendor: Mozilla 08:35:49 INFO - mozversion application_version: 48.0a1 08:35:49 INFO - mozversion platform_buildid: 20160406064719 08:35:49 INFO - mozversion platform_changeset: 963e2caee42cfcf4316e15bde8d8fbcdbbdc43f7 08:35:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:35:49 INFO - mozversion platform_version: 48.0a1 08:35:49 INFO - using testdate: 1459956949 08:35:49 INFO - actual date: 1459956949 08:35:49 INFO - starting webserver on 'localhost:49283' 08:35:49 INFO - SUITE-START | Running 2 tests 08:35:49 INFO - TEST-START | dromaeo_css 08:35:49 INFO - operating with platform_type : mac_ 08:35:49 INFO - Initialising browser for dromaeo_css test... 08:35:49 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpwYNaOX/profile http://localhost:49283/getInfo.html) 08:35:51 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 08:35:51 INFO - PROCESS | 1659 | colorDepth:24 08:35:51 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 08:35:51 INFO - PROCESS | 1659 | __metrics 08:35:51 INFO - PROCESS | 1659 | 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" 08:35:51 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:35:52 INFO - TEST-INFO | 1659: exit 0 08:35:52 INFO - Browser initialized. 08:35:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:35:52 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpwYNaOX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:04 INFO - PROCESS | 1661 | RSS: Main: 236240896 08:36:04 INFO - PROCESS | 1661 | 08:36:55 INFO - PROCESS | 1661 | 1459957015377 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] 08:39:05 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 08:39:06 INFO - PROCESS | 1661 | RSS: Main: 352247808 08:39:06 INFO - PROCESS | 1661 | 08:42:09 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 08:42:09 INFO - PROCESS | 1661 | RSS: Main: 363466752 08:42:09 INFO - PROCESS | 1661 | 08:45:11 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 08:45:12 INFO - PROCESS | 1661 | RSS: Main: 365793280 08:45:12 INFO - PROCESS | 1661 | 08:48:14 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 08:48:15 INFO - PROCESS | 1661 | RSS: Main: 324190208 08:48:15 INFO - PROCESS | 1661 | 08:51:18 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 08:51:18 INFO - PROCESS | 1661 | RSS: Main: 330092544 08:51:18 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 08:54:21 INFO - PROCESS | 1661 | RSS: Main: 445624320 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | __start_tp_report 08:54:21 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 08:54:21 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 08:54:21 INFO - PROCESS | 1661 | |i|pagename|runs| 08:54:21 INFO - PROCESS | 1661 | |0;dojo.html;3386.916186820217;3445.620981692012;3477.287156132992;3477.965220347799;3515.3496603128424;5507.669539827613;5594.720263986805;5648.548116150709;5652.434756524345;5655.519280861126;5596.188552659862;5649.689267090308;5665.093585026397;5665.8583535411635;5669.291338582677;5066;5080.237964305346;5093.567046801027;5106.744662766847;5168.147255702805;5164.147915593922;5164.354455693038;5178.585713142958;5180.6373553851245;5184.248283998818;5087.262346959688;5109.386873575176;5144.6913185209005;5151.845444636649;5159.71621560814;5119.948800511985;5159.871003224912;5169.922451163236;5171.405288391827;5230.137027390476;4985.601151907838;5016.122178618763;5026.447090820006;5078.009788091286;5103.081445339837;5545.944540554583;5563.332400111972;5571.637843540157;5579.079451890433;5664.971675141639;6163.2604087509335;6178.258608966908;6192.9380706192815;6204.844878878019;6214.844628884314;5018.84943451697;5180.430152683201;6051.848703782397;6258.655773932432;6259.6870156492;5746.856328591819;5747.971260143714;5757.337906140764;5768.97115514424;5785.1611516329895;6239.844003899939;6253.843653908689;6275.121482992385;6283.151774510474;6291.6854157291955;5970.373110823388;6032.698365081728;6100.944524685144;6117;6126.908096378558;6119.602225855305;6168;6193.411625895533;6204.441600255998;6208.751649933952;6081.726322315506;6129.938700612936;6143.232095988002;6144.41628045335;6152.477039451696;6080.726367313393;6089.85156853816;6135.477655820289;6143.696113957266;6170.845728856814;4887.608991280689;4888.388951381077;4898.485659005753;4902.950970490321;4905.7301848397965;4372.672049596293;4399.20814253431;4401.031773009932;4412.227860124465;4451.910961780811;5416.539594134464;5525.4474552545225;5527.447255274521;5527.806526771544;5559.694216818033;5182.948170518322;6104.822969073627;6167.414095660905;6190.597611155261;6200.3799620038535;5467.778982012752;5512.448755124536;5537.36320323168;5586;5621.15682647598;5332.786688532416;5336.573074154058;5342.545883599938;5350.063738845686;5373.194020896896;6266.968665156645;6274.403931626488;6276.089966954766;6282.905756413657;6295.811125666146;6135.416406698409;6140.600860944024;6196.442320191204;6211.006239001738;6237.844053898689;6249;6264.404881536247;6268.843278918063;6270.874582508415;6277.623342599459;6132.110843927695;6156.507479401547;6159.907601386072;6160.507159427325;6166.290876549075;6072.574919755575;6101.51991978472;6167.84580385494;6228.906566401417;6237.937620623918;6058.4850287724275;6069.605475644069;6086.513078953584;6091.238595175603;6123.8469038272615;5879.882402351844;6071.301800293023;6079.452849243589;6085.574009819447;6088.665123418077;5715.457031581993;5865.94134058654;5934.495567876779;5955.731992060454;5973.283206015306;5125.461826508312;6020.668863212565;6060.363661815446;6091.634501929899;6104.11490333908;5783.479486846204;5888.352281249145;5932.991391463375;5938.376470470538;5947.1079338099635 08:54:21 INFO - PROCESS | 1661 | |1;ext.html;432.32341385731326;545.9299772446005;575.6747437697701;634.0584232414864;641.0736485778051;24566.631500527506;30599.541006884916;30727.07818765435;30752.07743767685;30813.537796933066;30812.845935770347;31292.687073129262;40507;40985.7950710246;41038;9473.478958657272;9644.18024467921;9671.90328096717;9677.322587418883;9722.319437639368;9560.091791279818;9702.854457183148;9710.93179750227;9720.805583888317;9730.513474326292;9652.131308182263;9736.367136136128;9739.928607853131;9757.707268781947;9770.36492627977;9613.13481786639;9709;9788.755281117958;9808.754781130458;9834.704958851245;8407.03319118303;9651.613935442574;9665.226781857435;9692.806143877153;9788.657396991071;40299.17905746599;40852.59147408517;40852.77441676754;40867.59132408668;41079.589204108175;2971.6136902202793;2991.22228220662;3126.655538118608;3227.5804145461175;3408.6080100788477;25514.87242563794;28756.281092972633;28837.56743648847;29246;29369.412611747644;2678.638383818179;2732.1666891598056;2763.875625596833;2771.80597358185;2851.130405226405;484944.5752771249;488354;490411;491226;491292;44606.55393446089;61829.690851545456;62126;62352.06471902925;62431.6878415605;45125.87185320327;45373.54626453693;45432;45474.77262613732;45593.77203113963;15356.769648455282;15538.766918496232;15540.378384864705;15541.067535947654;15549.766753498707;12467.127301089018;12543.12198146121;12574.371281435891;12578.433970471167;12591.811122833165;14388.784168237486;14401.495947641992;14519.78220326696;14533.418663253351;14623.78064329036;5603.991281569275;6157.783198048699;6264.436200741864;6415.486761059104;6421.743130274736;930.8603709443638;986.4574484033752;988.649029594498;1025.8461230815437;1090.6946055104584;27345.86327068352;28916.710832891822;29227;29443.263918402212;29892.70107298899;959.1703176752059;1104.9779004420027;1105.9336439813476;1110.7167672243688;1201.1171788735273;14739.484118055816;14778.26108694561;14781.408743650349;15189.468368607046;15240.085594864122;535595;539861;546070.2696486493;546630;546988;59118.817623648145;59585;59586.70206649026;59690.40309596848;59752.10371844426;1297.2670441200692;1323.4110820684896;1407.9507217247346;1451.9709605807825;1473.4253641079988;22753.407261491535;29684.851575741985;29866.10401687953;29983.834336662407;30402.087937361914;49908.750456247486;50615.746921265156;51744;51778.22332664938;51787.48212517826;489019;504656;504837;505931.6441013551;506087;28720.994765183954;33574.32851343008;34032.65967340394;34625.480617791254;34893;43862;43965.560344397425;44102;44377.33433998428;44592.55407445884;35054.824725877224;36257.81871090628;36349.27301454009;36671.449928250564;37071.44392834056;35509.82245088758;35571;35720.64279357173;36187;36261.09347266339;27805.721942780314;31439.84280078585;36447.453288200166;36478.4528232082;37162.628373717;29812.51215753179;30676.079717608507;30827.84586077145;31857;31948.68051319457;19526.414207573795;22754.089836406358;23961.921713523283;24205.91073401666;24700.38249043788 08:54:21 INFO - PROCESS | 1661 | |2;jquery.html;365.9798711070891;366.92844895245423;373.71410870683934;376.555664316107;377.2022173103886;19379.515512112186;20161.39515814526;20203;20449.488762780937;20614.38156855293;19302.32441864535;19392.321268755597;19956.30152944647;20100.592958492874;20101.79389236647;5689.886202275962;5851;5897.52819774417;5912.290525136968;5914.970425147868;4167.416561681367;4195.916081678364;4463.152001119777;5853.61951473155;6463.7091330890225;6371.26730426;6397.456216221603;6403.455706264973;6407.455366293871;6411.230652321728;6359.523035772289;6364.109024736541;6368.044793281022;6375.203099612549;6377.489800815923;3730.7015438764834;5302.867428314285;5518.641288316287;5523.447655234485;5526.50261476469;23468.76531234683;24212.15257465998;24366.26901192967;24496.265112046665;24500.387490312707;2007.5081605006867;2203.3389983005195;2339.508703172336;2798.118592643311;2802.3274414140665;11504.884951150465;14176.29118544079;14181;14464.71070578593;14842.886783491282;1689.7887764029497;1705.4542546385162;1736.9044702541355;1746.2054765081857;1750.4923572164057;101020.98979010116;101078.49460752723;102892;103745.48127259391;104178;9547.474888881039;10621.990910863455;10783.245172837984;10851;10936.234463587632;11922.701932451584;12976.63745306748;13507.459701611826;13535.120217185851;13566.59300220995;6656.267810540837;8329.583520824055;8356.456830306011;8358.540280284642;8431.451955622864;6905.551139175937;8412.158784121539;8428.620712067972;8442.240198382053;8539.146085391536;4307.763073030951;4330.675199360061;4356.542563030899;4385.736855788663;4397.846075387346;1552.208373729406;1790.5255107396551;1792.919755908472;1830.7253911913053;1832.1480511562188;914.3736540469799;927.0914503786328;952.5999080386255;954.2556805691572;990.6829814459304;19051.047447627563;19731.901340493205;19828.90085549592;19865.106070226873;20043.398698039084;898.2320116300469;952.3904700991371;964.2932010341796;976.8681228034267;993.145894530703;10488.737781555523;10657.040866322068;10684.89315106839;10700.197485188643;10725.946370268099;609949;611241;624080;629687;630488;82282;119214.4039279798;119375.40312298383;123396;123734;1010.4838951011927;1018.5263852308713;1035.6841163445222;1083.1118482843992;1083.9024487796137;17524.386646467312;17553.736693949344;18254;18436.631267374847;18439.53901152428;53255;53848.80738715098;54151.18773218326;54901.72549137389;56288.87422251614;74557.2544274572;75174.49651006839;76465;76934;77242;7632.8855067175145;7761.4178936578855;7812.609369531614;7876.763697089096;8109.513429194267;7005.439564834699;10654.680359589225;11421.37182454973;12304.938475307566;12591.433385497858;10191.796164076528;10647.361158330525;10790.73023174427;11001.339919604849;11065.723356916142;10661.360318380923;10695.679129625812;10735.194860385658;10783.838242426213;10893.509792059218;10863.022327990519;10924.726881828017;11261.155413343868;11268;11281.041111505614;7559.828226624882;7690.384769218561;7692.38460923136;7718.266764657348;8051.557164356017;10420.478976051016;10647.893521065;10908.61819836302;10941.07000904932;10945.398003109905 08:54:21 INFO - PROCESS | 1661 | |3;mootools.html;1204.704942187149;1567.3573834727763;1593.8645215156712;1860.8325250727432;1998.4704053425844;7856.057273127226;8647;8844.823103537925;8881.422707524007;8881.911180888206;8520.95739521303;8785.64857405703;8785.692500762474;8786.033536311;8792.51641159736;2421.128393778238;2452.9632055519182;2453.276283496364;2453.6074228123503;2454.2882564056404;2353.752855950126;2398.7481314461993;2400.699912510936;2403.2910291463972;2427.672264244331;2258.706368172135;2272.8409011369213;2443.7922776564014;2482.441450673593;2486.117428312941;2446.645236440706;2452.460458699092;2466.3094333586623;2484.8260621756485;2555.258974897287;2419.8669073200967;2470.3824043989002;2480.8015358771254;2483.4412257242157;2492.6385674077155;7416.703331866719;8845.734627961107;8855.911440885573;8930.86603700945;8937.73186804397;5317.494837990384;5462;5472.671639701631;5474.808381706661;5476.17857321401;3508.3684936711384;3553.6091029986683;3633.5276414066;3637.672609465161;3668.192997540537;1023.749181450542;1045.6288017753664;1046.1055797293282;1052.8157572424795;1058.1746237934424;11998.940005300004;12025.917667409887;12051.096167787451;12085.758284834254;12085.912267895843;4752.5485078917445;4781.6891902026255;4784.68899521537;4844.619283504185;4857;10120.139788118093;10147.847782283272;10158.08577228053;10159.847602285972;10163.288569800043;5471.945280547144;5475.014497390508;5475.835724928259;5478.342598888159;5478.506934375846;4059.9594004060173;4420.58004489573;4628.976855115703;4921.163402221631;4986.626003049786;3801.467794508771;3840.0975770693863;3875.767453952772;3891.8443262269757;3903.1608204236227;1290.9225446473242;1310.4954592481963;1314.3165553912104;1324.3973991833693;1326.7744483437646;966.8888077870994;1000.5397517142051;1005.2711783956573;1008.4000019988096;1031.9896801032044;7955.363570914313;8081.595920203967;8086.393520485987;8090.231428014329;8094.392920530866;1108.9611863584896;1114.7603265298;1120.9047230985295;1125.9943700281447;1157.0685598093448;6096.786612468631;6157.076438534255;6223.906641400383;6241.656708880964;6249.218847644044;10316.742081448025;10455.954404559483;10751.19366047534;10867.130629549618;10869.45652717361;10483.0041146091;10583.206259530412;10585.259031867849;10628.309159904582;10649.094826939798;7595.278448547379;8170.060443049007;8308.584570771438;8386.538740369217;8419.494830310201;7804.414668899742;7849.60751962411;7860.882086768817;7861.724839630586;7885.2114788520685;9350.392224505385;9370.718878433658;9480.668176614061;9633;9688.370255933341;9559.761005974906;9804.215662747105;9844.60621575129;10027.949860250652;10051.597936082768;6566.606003639797;6726.596404215763;7163.570185788869;7314.817129571803;7398.298391370123;8201.466904651179;8209.507429554245;8237.588120594066;8249.216324449168;8264.132266111972;7095.609741464269;7373.77878663641;7402.7409040683315;7512.136104347851;7570.470067095471;6360.904586431115;7100.437903661186;7208.45936554771;7312.305330993547;7362.263773622809;7629.122650895218;7734.110577283459;7735.187805280365;7740.8451830964195;7745.109312428917;6952.895706564506;6955.234924158237;7029.332213439715;7040.1551813780625;7068.187158476635;7033.824154395977;7120.1099862517185;7135.678894449866;7151.82120446993;7169.283071692789 08:54:21 INFO - PROCESS | 1661 | |4;prototype.html;326.1812849747135;326.67822195137785;331.0961076261807;334.27629182819203;336.2317105414128;6364.236291645003;6385.393387628168;6403.23161220653;6419.293877673452;6421.422072013518;6238.0642903564485;6332.7466901324005;6389.488840892729;6492;6502.934970650292;4506.369108324837;4586.908261834778;4609.939713865813;4695.272232803921;4722.64580156488;4693.624510039206;4694.647901407408;4704.435467743859;4704.882377940562;4722.551357621038;4685.60172385346;4699.788509517063;4700.435947686283;4713.151632706112;4719.457262414832;4510.751908645023;4571.725696458207;4647.000894807633;4648.1400940825715;4675.555822196886;4034.9394759078637;4037.6971727120585;4042.535108462535;4046.7167298289132;4050.4126901599398;4918.434380046269;6038.18484504595;6079.240094988127;6105.603135796159;6127.11156882254;5524.779008839641;5535.529479994165;5539.169124631298;5545.889082218373;5559.833205003856;6744.93255067448;6749;6759.7296108155615;6773.254941956381;6780.491463140235;4424.269995450747;4562.520935301812;4572.222722137245;4607.9308810367875;4609.9308510372375;7031.718731250744;7094.1841688206005;7102.112235970504;7103.360697537195;7109.82225444368;3913.021744563859;4611.815527378934;4649.18639238132;4658.440987081572;4660.207764680013;4695.718256904528;4715.41057367829;4717.740524271198;4720.669553131316;4732.0772449372735;5501.14732216507;5502.367227768777;5509.531689806331;5522.834314970557;5540.168974653753;6368.808935731936;6378.77674281398;6739.157605299338;6788.981652752028;6825.146856642919;1549.9460366950357;1565.2565031609895;1580.8498192671677;1585.326236349547;1585.4292454716292;951.9714408567754;970.6020531582018;1000.5347513406301;1001.114014097529;1024.3034736379334;6110.541709371815;6238.313785483593;6243.937560624336;6253.249610046823;6262.6868656566985;7070.39901608369;7073.363397294268;7093.32613401726;7098.077249957472;7114.71541138359;6206.348333425016;6236.18929539157;6239.78160764371;6273.435390814849;6275.937240627535;3682.1531047859144;3737.981310093432;3741.7567858089137;3743.6069212732814;3744.85020599173;6273.905891411632;7029.118061594721;7192.352688258082;7222.349988500955;7319.8536029280185;7215.242399548077;7245.384142347854;7255.818604534823;7260.92739072613;7273.89089163663;7298.306660867209;7317.304856038668;7330.963345183133;7334.96332518334;7336;5851.736671849691;6943.895841562279;7040.225575186623;7061.717531298896;7081.575105493687;6234.75060997555;6552.443042341454;6866.141732283465;6911.723531058701;6931.064306318583;7160.10498687664;7186.676599552928;7199.892001620085;7214.819629509095;7229.240929702516;4478.507364189872;4519.525449827721;4523.326369243401;4533.184026875194;4547;6314.673918477171;6538.378854008862;7043.823904402431;7048.8590228194125;7088.503804733619;6481.546291759531;6726.461883049442;6732.182310776161;6847.21257055445;6847.794566163023;6723.865522689616;6779.559328643622;6787.117674702257;6790.388865002174;6800.081988931431;6636.767713130017;6645.867082658223;6668.199816022108;6669.899951500828;6671.39957403836;5494.642848214853;6792.320767923168;6794.04883316346;6795.966020169867;6796;6374.840628984127;6644.83387915306;6652.73389064432;6661.433778128913;6688.197416310074 08:54:21 INFO - PROCESS | 1661 | |5;yui.html;663.621735610702;740.1820987808471;749.8987636669051;752.356734991582;761.9123800762907;12692.936535317322;15193.240337983098;16524.25640846163;16946.576335591617;17010.40463583775;15625.921870390632;15698.37206511738;15747.370105195807;15765.975211611238;15769.684606307866;732.2604169788499;886.0652012127204;911.2300106410073;913.7030465098869;917.0829170829171;728.3372131360463;905.9048799875984;918.191991047877;920.1350730313517;923.353652443289;913.5067063785548;948.5446985446989;951.0727041134872;964.1515466389567;965.1458459263567;760.9086909570832;773.8529679360903;904.2494729374604;946.356477595235;950.7670620697938;572.0675299262217;705.3722187253348;707.9327463890974;714.0681410758957;714.2179313651543;15038.849611503854;15130.016548924285;15131.167785771779;15134.167620780963;15135.318910648937;12088.09339299556;12091.214071085351;12229.571964981273;12424.56514022005;12477.812832807514;9781.41311521311;9845.901540984642;9884;10075.798484030352;10215.080642742114;2965.4217427601625;3397.7961322320493;3426.229098452853;3464.185916309665;3538.150843797496;61391.38608613901;78790;79510.60244698798;79553;79562.40875182464;8231.300339471092;9114.865603961769;9197.908020919838;9237.261019118454;9259.398139120936;20442.182312707326;20894.47763805917;20915.895420523106;20932.16271349129;20997.790022099583;6188.783392581238;7215.567065976058;7322.780316590511;7376.483646144826;7409.259074092548;4051.331530297527;4114.136031433372;4116.217918595517;4118.608732170439;4137.193247316744;3506.1234691327168;3565.2156525564333;3566.1797786509246;3568.678818906311;3600.243948770735;645.0743183531647;649.4674367019094;662.483263054818;669.6149713914518;670.3363669966698;525.9211118332204;575.1516513143081;595.76765061626;602.3344204653882;610.5756499233079;8052.235037671412;8122.918770812216;8186.754397368089;8200.343972482187;8286.668533258602;519.366373024909;558.9552835773128;579.8776478090169;580.2949416459022;607.6718571971174;2825.4914115459005;3782.149016471327;3800.1829606634706;3866.226754649025;3902.23906338267;87107.56446217728;88644;89309.94315767288;89382.65926011115;89690;71401.64299178471;72542.63728681323;74671;76198;77770;61479.692601536706;62378.37621623816;62596.687016564625;62797.744045119754;63175.6841215791;7665.38676905835;7773.067231931978;7778.611069446391;7791;7824.374050075867;48936.2659560114;49517;49805;49911.25133122934;50392.99214015626;60621.69689151702;63239.6838015807;66946;67147;68170.3182968164;9887.653932112342;9970.601175952881;9974.152197063331;10145.18838492904;10558.894769893135;10888.020078193;10902.073323767569;11311.925367090113;11314.208005439541;11349.602763903224;10291.125254353165;10323.122534584343;10335.638252661121;10375;10729.46352682347;10353.275270730977;10484.842727358942;10686.198535110054;10725.141988640735;10928.071113955402;10187.134093602126;10324.48377581103;10337.0696637303;10345.275830691779;10899.128069754242;7737.883931741141;7745.92254077452;8723.011285850285;9100.863487047833;9255.35212535116;8194.42639015287;8563.100874408346;8613.82772344537;8903.910960890309;9070.138336857988 08:54:21 INFO - PROCESS | 1661 | __end_tp_report 08:54:21 INFO - PROCESS | 1661 | __start_cc_report 08:54:21 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1073 08:54:21 INFO - PROCESS | 1661 | __end_cc_report 08:54:21 INFO - PROCESS | 1661 | __startTimestamp1459958061645__endTimestamp 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | ------- Summary: start ------- 08:54:21 INFO - PROCESS | 1661 | Number of tests: 6 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5664.30 Median:5879.88 stddev:626.41 (10.7%) stddev-sans-first:602.32 08:54:21 INFO - PROCESS | 1661 | Values: 3386.9 3445.6 3477.3 3478.0 3515.3 5507.7 5594.7 5648.5 5652.4 5655.5 5596.2 5649.7 5665.1 5665.9 5669.3 5066.0 5080.2 5093.6 5106.7 5168.1 5164.1 5164.4 5178.6 5180.6 5184.2 5087.3 5109.4 5144.7 5151.8 5159.7 5119.9 5159.9 5169.9 5171.4 5230.1 4985.6 5016.1 5026.4 5078.0 5103.1 5545.9 5563.3 5571.6 5579.1 5665.0 6163.3 6178.3 6192.9 6204.8 6214.8 5018.8 5180.4 6051.8 6258.7 6259.7 5746.9 5748.0 5757.3 5769.0 5785.2 6239.8 6253.8 6275.1 6283.2 6291.7 5970.4 6032.7 6100.9 6117.0 6126.9 6119.6 6168.0 6193.4 6204.4 6208.8 6081.7 6129.9 6143.2 6144.4 6152.5 6080.7 6089.9 6135.5 6143.7 6170.8 4887.6 4888.4 4898.5 4903.0 4905.7 4372.7 4399.2 4401.0 4412.2 4451.9 5416.5 5525.4 5527.4 5527.8 5559.7 5182.9 6104.8 6167.4 6190.6 6200.4 5467.8 5512.4 5537.4 5586.0 5621.2 5332.8 5336.6 5342.5 5350.1 5373.2 6267.0 6274.4 6276.1 6282.9 6295.8 6135.4 6140.6 6196.4 6211.0 6237.8 6249.0 6264.4 6268.8 6270.9 6277.6 6132.1 6156.5 6159.9 6160.5 6166.3 6072.6 6101.5 6167.8 6228.9 6237.9 6058.5 6069.6 6086.5 6091.2 6123.8 5879.9 6071.3 6079.5 6085.6 6088.7 5715.5 5865.9 5934.5 5955.7 5973.3 5125.5 6020.7 6060.4 6091.6 6104.1 5783.5 5888.4 5933.0 5938.4 5947.1 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:63930.50 Median:36871.45 stddev:136503.80 (370.2%) stddev-sans-first:136803.47 08:54:21 INFO - PROCESS | 1661 | Values: 432.3 545.9 575.7 634.1 641.1 24566.6 30599.5 30727.1 30752.1 30813.5 30812.8 31292.7 40507.0 40985.8 41038.0 9473.5 9644.2 9671.9 9677.3 9722.3 9560.1 9702.9 9710.9 9720.8 9730.5 9652.1 9736.4 9739.9 9757.7 9770.4 9613.1 9709.0 9788.8 9808.8 9834.7 8407.0 9651.6 9665.2 9692.8 9788.7 40299.2 40852.6 40852.8 40867.6 41079.6 2971.6 2991.2 3126.7 3227.6 3408.6 25514.9 28756.3 28837.6 29246.0 29369.4 2678.6 2732.2 2763.9 2771.8 2851.1 484944.6 488354.0 490411.0 491226.0 491292.0 44606.6 61829.7 62126.0 62352.1 62431.7 45125.9 45373.5 45432.0 45474.8 45593.8 15356.8 15538.8 15540.4 15541.1 15549.8 12467.1 12543.1 12574.4 12578.4 12591.8 14388.8 14401.5 14519.8 14533.4 14623.8 5604.0 6157.8 6264.4 6415.5 6421.7 930.9 986.5 988.6 1025.8 1090.7 27345.9 28916.7 29227.0 29443.3 29892.7 959.2 1105.0 1105.9 1110.7 1201.1 14739.5 14778.3 14781.4 15189.5 15240.1 535595.0 539861.0 546070.3 546630.0 546988.0 59118.8 59585.0 59586.7 59690.4 59752.1 1297.3 1323.4 1408.0 1452.0 1473.4 22753.4 29684.9 29866.1 29983.8 30402.1 49908.8 50615.7 51744.0 51778.2 51787.5 489019.0 504656.0 504837.0 505931.6 506087.0 28721.0 33574.3 34032.7 34625.5 34893.0 43862.0 43965.6 44102.0 44377.3 44592.6 35054.8 36257.8 36349.3 36671.4 37071.4 35509.8 35571.0 35720.6 36187.0 36261.1 27805.7 31439.8 36447.5 36478.5 37162.6 29812.5 30676.1 30827.8 31857.0 31948.7 19526.4 22754.1 23961.9 24205.9 24700.4 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34615.44 Median:23840.46 stddev:102873.02 (431.5%) stddev-sans-first:103129.46 08:54:21 INFO - PROCESS | 1661 | Values: 366.0 366.9 373.7 376.6 377.2 19379.5 20161.4 20203.0 20449.5 20614.4 19302.3 19392.3 19956.3 20100.6 20101.8 5689.9 5851.0 5897.5 5912.3 5915.0 4167.4 4195.9 4463.2 5853.6 6463.7 6371.3 6397.5 6403.5 6407.5 6411.2 6359.5 6364.1 6368.0 6375.2 6377.5 3730.7 5302.9 5518.6 5523.4 5526.5 23468.8 24212.2 24366.3 24496.3 24500.4 2007.5 2203.3 2339.5 2798.1 2802.3 11504.9 14176.3 14181.0 14464.7 14842.9 1689.8 1705.5 1736.9 1746.2 1750.5 101021.0 101078.5 102892.0 103745.5 104178.0 9547.5 10622.0 10783.2 10851.0 10936.2 11922.7 12976.6 13507.5 13535.1 13566.6 6656.3 8329.6 8356.5 8358.5 8431.5 6905.6 8412.2 8428.6 8442.2 8539.1 4307.8 4330.7 4356.5 4385.7 4397.8 1552.2 1790.5 1792.9 1830.7 1832.1 914.4 927.1 952.6 954.3 990.7 19051.0 19731.9 19828.9 19865.1 20043.4 898.2 952.4 964.3 976.9 993.1 10488.7 10657.0 10684.9 10700.2 10725.9 609949.0 611241.0 624080.0 629687.0 630488.0 82282.0 119214.4 119375.4 123396.0 123734.0 1010.5 1018.5 1035.7 1083.1 1083.9 17524.4 17553.7 18254.0 18436.6 18439.5 53255.0 53848.8 54151.2 54901.7 56288.9 74557.3 75174.5 76465.0 76934.0 77242.0 7632.9 7761.4 7812.6 7876.8 8109.5 7005.4 10654.7 11421.4 12304.9 12591.4 10191.8 10647.4 10790.7 11001.3 11065.7 10661.4 10695.7 10735.2 10783.8 10893.5 10863.0 10924.7 11261.2 11268.0 11281.0 7559.8 7690.4 7692.4 7718.3 8051.6 10420.5 10647.9 10908.6 10941.1 10945.4 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:6019.81 Median:5152.06 stddev:3192.00 (62.0%) stddev-sans-first:3180.42 08:54:21 INFO - PROCESS | 1661 | Values: 1204.7 1567.4 1593.9 1860.8 1998.5 7856.1 8647.0 8844.8 8881.4 8881.9 8521.0 8785.6 8785.7 8786.0 8792.5 2421.1 2453.0 2453.3 2453.6 2454.3 2353.8 2398.7 2400.7 2403.3 2427.7 2258.7 2272.8 2443.8 2482.4 2486.1 2446.6 2452.5 2466.3 2484.8 2555.3 2419.9 2470.4 2480.8 2483.4 2492.6 7416.7 8845.7 8855.9 8930.9 8937.7 5317.5 5462.0 5472.7 5474.8 5476.2 3508.4 3553.6 3633.5 3637.7 3668.2 1023.7 1045.6 1046.1 1052.8 1058.2 11998.9 12025.9 12051.1 12085.8 12085.9 4752.5 4781.7 4784.7 4844.6 4857.0 10120.1 10147.8 10158.1 10159.8 10163.3 5471.9 5475.0 5475.8 5478.3 5478.5 4060.0 4420.6 4629.0 4921.2 4986.6 3801.5 3840.1 3875.8 3891.8 3903.2 1290.9 1310.5 1314.3 1324.4 1326.8 966.9 1000.5 1005.3 1008.4 1032.0 7955.4 8081.6 8086.4 8090.2 8094.4 1109.0 1114.8 1120.9 1126.0 1157.1 6096.8 6157.1 6223.9 6241.7 6249.2 10316.7 10456.0 10751.2 10867.1 10869.5 10483.0 10583.2 10585.3 10628.3 10649.1 7595.3 8170.1 8308.6 8386.5 8419.5 7804.4 7849.6 7860.9 7861.7 7885.2 9350.4 9370.7 9480.7 9633.0 9688.4 9559.8 9804.2 9844.6 10027.9 10051.6 6566.6 6726.6 7163.6 7314.8 7398.3 8201.5 8209.5 8237.6 8249.2 8264.1 7095.6 7373.8 7402.7 7512.1 7570.5 6360.9 7100.4 7208.5 7312.3 7362.3 7629.1 7734.1 7735.2 7740.8 7745.1 6952.9 6955.2 7029.3 7040.2 7068.2 7033.8 7120.1 7135.7 7151.8 7169.3 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5547.48 Median:6273.67 stddev:1745.04 (27.8%) stddev-sans-first:1705.37 08:54:21 INFO - PROCESS | 1661 | Values: 326.2 326.7 331.1 334.3 336.2 6364.2 6385.4 6403.2 6419.3 6421.4 6238.1 6332.7 6389.5 6492.0 6502.9 4506.4 4586.9 4609.9 4695.3 4722.6 4693.6 4694.6 4704.4 4704.9 4722.6 4685.6 4699.8 4700.4 4713.2 4719.5 4510.8 4571.7 4647.0 4648.1 4675.6 4034.9 4037.7 4042.5 4046.7 4050.4 4918.4 6038.2 6079.2 6105.6 6127.1 5524.8 5535.5 5539.2 5545.9 5559.8 6744.9 6749.0 6759.7 6773.3 6780.5 4424.3 4562.5 4572.2 4607.9 4609.9 7031.7 7094.2 7102.1 7103.4 7109.8 3913.0 4611.8 4649.2 4658.4 4660.2 4695.7 4715.4 4717.7 4720.7 4732.1 5501.1 5502.4 5509.5 5522.8 5540.2 6368.8 6378.8 6739.2 6789.0 6825.1 1549.9 1565.3 1580.8 1585.3 1585.4 952.0 970.6 1000.5 1001.1 1024.3 6110.5 6238.3 6243.9 6253.2 6262.7 7070.4 7073.4 7093.3 7098.1 7114.7 6206.3 6236.2 6239.8 6273.4 6275.9 3682.2 3738.0 3741.8 3743.6 3744.9 6273.9 7029.1 7192.4 7222.3 7319.9 7215.2 7245.4 7255.8 7260.9 7273.9 7298.3 7317.3 7331.0 7335.0 7336.0 5851.7 6943.9 7040.2 7061.7 7081.6 6234.8 6552.4 6866.1 6911.7 6931.1 7160.1 7186.7 7199.9 7214.8 7229.2 4478.5 4519.5 4523.3 4533.2 4547.0 6314.7 6538.4 7043.8 7048.9 7088.5 6481.5 6726.5 6732.2 6847.2 6847.8 6723.9 6779.6 6787.1 6790.4 6800.1 6636.8 6645.9 6668.2 6669.9 6671.4 5494.6 6792.3 6794.0 6796.0 6796.0 6374.8 6644.8 6652.7 6661.4 6688.2 08:54:21 INFO - PROCESS | 1661 | 08:54:21 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17486.29 Median:62697.22 stddev:24393.77 (38.9%) stddev-sans-first:24429.49 08:54:21 INFO - PROCESS | 1661 | Values: 663.6 740.2 749.9 752.4 761.9 12692.9 15193.2 16524.3 16946.6 17010.4 15625.9 15698.4 15747.4 15766.0 15769.7 732.3 886.1 911.2 913.7 917.1 728.3 905.9 918.2 920.1 923.4 913.5 948.5 951.1 964.2 965.1 760.9 773.9 904.2 946.4 950.8 572.1 705.4 707.9 714.1 714.2 15038.8 15130.0 15131.2 15134.2 15135.3 12088.1 12091.2 12229.6 12424.6 12477.8 9781.4 9845.9 9884.0 10075.8 10215.1 2965.4 3397.8 3426.2 3464.2 3538.2 61391.4 78790.0 79510.6 79553.0 79562.4 8231.3 9114.9 9197.9 9237.3 9259.4 20442.2 20894.5 20915.9 20932.2 20997.8 6188.8 7215.6 7322.8 7376.5 7409.3 4051.3 4114.1 4116.2 4118.6 4137.2 3506.1 3565.2 3566.2 3568.7 3600.2 645.1 649.5 662.5 669.6 670.3 525.9 575.2 595.8 602.3 610.6 8052.2 8122.9 8186.8 8200.3 8286.7 519.4 559.0 579.9 580.3 607.7 2825.5 3782.1 3800.2 3866.2 3902.2 87107.6 88644.0 89309.9 89382.7 89690.0 71401.6 72542.6 74671.0 76198.0 77770.0 61479.7 62378.4 62596.7 62797.7 63175.7 7665.4 7773.1 7778.6 7791.0 7824.4 48936.3 49517.0 49805.0 49911.3 50393.0 60621.7 63239.7 66946.0 67147.0 68170.3 9887.7 9970.6 9974.2 10145.2 10558.9 10888.0 10902.1 11311.9 11314.2 11349.6 10291.1 10323.1 10335.6 10375.0 10729.5 10353.3 10484.8 10686.2 10725.1 10928.1 10187.1 10324.5 10337.1 10345.3 10899.1 7737.9 7745.9 8723.0 9100.9 9255.4 8194.4 8563.1 8613.8 8903.9 9070.1 08:54:21 INFO - PROCESS | 1661 | -------- Summary: end -------- 08:54:21 INFO - PROCESS | 1661 | 08:54:22 INFO - TEST-INFO | 1661: exit 0 08:54:22 INFO - TEST-OK | dromaeo_css | took 1113038ms 08:54:22 INFO - TEST-START | kraken 08:54:22 INFO - operating with platform_type : mac_ 08:54:22 INFO - Initialising browser for kraken test... 08:54:22 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpNVwG0E/profile http://localhost:49283/getInfo.html) 08:54:24 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 08:54:24 INFO - PROCESS | 1667 | colorDepth:24 08:54:24 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 08:54:24 INFO - PROCESS | 1667 | __metrics 08:54:24 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:24 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:54:25 INFO - TEST-INFO | 1667: exit 0 08:54:25 INFO - Browser initialized. 08:54:25 INFO - Running cycle 1/1 for kraken test... 08:54:25 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jf/19plt40543lf16nnblwl7x1c00000w/T/tmpNVwG0E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:37 INFO - PROCESS | 1669 | RSS: Main: 236822528 08:54:37 INFO - PROCESS | 1669 | 08:54:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 08:54:40 INFO - PROCESS | 1669 | RSS: Main: 283283456 08:54:40 INFO - PROCESS | 1669 | 08:54:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 08:54:43 INFO - PROCESS | 1669 | RSS: Main: 293605376 08:54:43 INFO - PROCESS | 1669 | 08:54:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 08:54:47 INFO - PROCESS | 1669 | RSS: Main: 279982080 08:54:47 INFO - PROCESS | 1669 | 08:54:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 08:54:49 INFO - PROCESS | 1669 | RSS: Main: 282943488 08:54:49 INFO - PROCESS | 1669 | 08:54:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:54:52 INFO - PROCESS | 1669 | RSS: Main: 282845184 08:54:52 INFO - PROCESS | 1669 | 08:54:55 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 08:54:55 INFO - PROCESS | 1669 | RSS: Main: 282783744 08:54:55 INFO - PROCESS | 1669 | 08:54:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 08:54:59 INFO - PROCESS | 1669 | RSS: Main: 282877952 08:54:59 INFO - PROCESS | 1669 | 08:55:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 08:55:02 INFO - PROCESS | 1669 | RSS: Main: 283275264 08:55:02 INFO - PROCESS | 1669 | 08:55:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:55:05 INFO - PROCESS | 1669 | RSS: Main: 318226432 08:55:05 INFO - PROCESS | 1669 | 08:55:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:55:07 INFO - PROCESS | 1669 | RSS: Main: 318021632 08:55:07 INFO - PROCESS | 1669 | 08:55:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:55:10 INFO - PROCESS | 1669 | RSS: Main: 323264512 08:55:10 INFO - PROCESS | 1669 | 08:55:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:55:13 INFO - PROCESS | 1669 | RSS: Main: 324935680 08:55:13 INFO - PROCESS | 1669 | 08:55:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:55:16 INFO - PROCESS | 1669 | RSS: Main: 325091328 08:55:16 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 08:55:18 INFO - PROCESS | 1669 | RSS: Main: 388018176 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | __start_tp_report 08:55:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 08:55:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 08:55:18 INFO - PROCESS | 1669 | |i|pagename|runs| 08:55:18 INFO - PROCESS | 1669 | |0;ai-astar;111;108;109;107;110;109;115;110;110;109 08:55:18 INFO - PROCESS | 1669 | |1;audio-beat-detection;156;127;141;160;118;144;138;119;165;119 08:55:18 INFO - PROCESS | 1669 | |2;audio-dft;185;185;185;185;182;182;184;183;180;219 08:55:18 INFO - PROCESS | 1669 | |3;audio-fft;74;76;83;82;57;57;58;76;78;56 08:55:18 INFO - PROCESS | 1669 | |4;audio-oscillator;95;97;127;78;77;83;116;79;79;116 08:55:18 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;86;83;88;82;85;74;134;129;87;82 08:55:18 INFO - PROCESS | 1669 | |6;imaging-darkroom;92;91;93;92;121;147;98;92;92;100 08:55:18 INFO - PROCESS | 1669 | |7;imaging-desaturate;85;85;110;146;144;84;87;87;84;84 08:55:18 INFO - PROCESS | 1669 | |8;json-parse-financial;54;54;55;54;53;53;54;63;55;51 08:55:18 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;64;65;76;74;71;68;68;67;67;68 08:55:18 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;83;100;110;85;83;92;92;110;110;83 08:55:18 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;129;123;134;132;119;124;134;135;131;117 08:55:18 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;139;130;139;139;139;128;139;141;139;139 08:55:18 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;68;68;66;68;89;95;96;97;67;66 08:55:18 INFO - PROCESS | 1669 | __end_tp_report 08:55:18 INFO - PROCESS | 1669 | __start_cc_report 08:55:18 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1275 08:55:18 INFO - PROCESS | 1669 | __end_cc_report 08:55:18 INFO - PROCESS | 1669 | __startTimestamp1459958118687__endTimestamp 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | ------- Summary: start ------- 08:55:18 INFO - PROCESS | 1669 | Number of tests: 14 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:109.80 Median:110.00 stddev:2.15 (2.0%) stddev-sans-first:2.24 08:55:18 INFO - PROCESS | 1669 | Values: 111.0 108.0 109.0 107.0 110.0 109.0 115.0 110.0 110.0 109.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:142.50 stddev:17.70 (12.4%) stddev-sans-first:17.63 08:55:18 INFO - PROCESS | 1669 | Values: 156.0 127.0 141.0 160.0 118.0 144.0 138.0 119.0 165.0 119.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:187.00 Median:185.00 stddev:11.37 (6.1%) stddev-sans-first:12.04 08:55:18 INFO - PROCESS | 1669 | Values: 185.0 185.0 185.0 185.0 182.0 182.0 184.0 183.0 180.0 219.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:69.70 Median:76.00 stddev:11.26 (14.8%) stddev-sans-first:11.84 08:55:18 INFO - PROCESS | 1669 | Values: 74.0 76.0 83.0 82.0 57.0 57.0 58.0 76.0 78.0 56.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:18.79 (23.8%) stddev-sans-first:19.93 08:55:18 INFO - PROCESS | 1669 | Values: 95.0 97.0 127.0 78.0 77.0 83.0 116.0 79.0 79.0 116.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:84.00 stddev:20.69 (24.6%) stddev-sans-first:21.79 08:55:18 INFO - PROCESS | 1669 | Values: 86.0 83.0 88.0 82.0 85.0 74.0 134.0 129.0 87.0 82.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:101.80 Median:92.00 stddev:18.28 (19.9%) stddev-sans-first:19.04 08:55:18 INFO - PROCESS | 1669 | Values: 92.0 91.0 93.0 92.0 121.0 147.0 98.0 92.0 92.0 100.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:99.60 Median:84.50 stddev:25.18 (29.8%) stddev-sans-first:26.15 08:55:18 INFO - PROCESS | 1669 | Values: 85.0 85.0 110.0 146.0 144.0 84.0 87.0 87.0 84.0 84.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.17 (5.9%) stddev-sans-first:3.35 08:55:18 INFO - PROCESS | 1669 | Values: 54.0 54.0 55.0 54.0 53.0 53.0 54.0 63.0 55.0 51.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.00 stddev:3.79 (5.6%) stddev-sans-first:3.61 08:55:18 INFO - PROCESS | 1669 | Values: 64.0 65.0 76.0 74.0 71.0 68.0 68.0 67.0 67.0 68.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:94.80 Median:83.00 stddev:11.78 (14.2%) stddev-sans-first:11.70 08:55:18 INFO - PROCESS | 1669 | Values: 83.0 100.0 110.0 85.0 83.0 92.0 92.0 110.0 110.0 83.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:127.80 Median:131.50 stddev:6.58 (5.0%) stddev-sans-first:6.96 08:55:18 INFO - PROCESS | 1669 | Values: 129.0 123.0 134.0 132.0 119.0 124.0 134.0 135.0 131.0 117.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:139.00 stddev:4.39 (3.2%) stddev-sans-first:4.61 08:55:18 INFO - PROCESS | 1669 | Values: 139.0 130.0 139.0 139.0 139.0 128.0 139.0 141.0 139.0 139.0 08:55:18 INFO - PROCESS | 1669 | 08:55:18 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.00 Median:78.50 stddev:14.16 (18.0%) stddev-sans-first:14.55 08:55:18 INFO - PROCESS | 1669 | Values: 68.0 68.0 66.0 68.0 89.0 95.0 96.0 97.0 67.0 66.0 08:55:18 INFO - PROCESS | 1669 | -------- Summary: end -------- 08:55:18 INFO - PROCESS | 1669 | 08:55:19 INFO - TEST-INFO | 1669: exit 0 08:55:19 INFO - TEST-OK | kraken | took 57150ms 08:55:19 INFO - SUITE-END | took 1170s 08:55:19 INFO - Completed test suite (00:19:30) 08:55:19 INFO - javascript benchmark 08:55:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3386.916186820217, 3445.620981692012, 3477.287156132992, 3477.965220347799, 3515.3496603128424, 5507.669539827613, 5594.720263986805, 5648.548116150709, 5652.434756524345, 5655.519280861126, 5596.188552659862, 5649.689267090308, 5665.093585026397, 5665.8583535411635, 5669.291338582677, 5066.0, 5080.237964305346, 5093.567046801027, 5106.744662766847, 5168.147255702805, 5164.147915593922, 5164.354455693038, 5178.585713142958, 5180.6373553851245, 5184.248283998818, 5087.262346959688, 5109.386873575176, 5144.6913185209005, 5151.845444636649, 5159.71621560814, 5119.948800511985, 5159.871003224912, 5169.922451163236, 5171.405288391827, 5230.137027390476, 4985.601151907838, 5016.122178618763, 5026.447090820006, 5078.009788091286, 5103.081445339837, 5545.944540554583, 5563.332400111972, 5571.637843540157, 5579.079451890433, 5664.971675141639, 6163.2604087509335, 6178.258608966908, 6192.9380706192815, 6204.844878878019, 6214.844628884314, 5018.84943451697, 5180.430152683201, 6051.848703782397, 6258.655773932432, 6259.6870156492, 5746.856328591819, 5747.971260143714, 5757.337906140764, 5768.97115514424, 5785.1611516329895, 6239.844003899939, 6253.843653908689, 6275.121482992385, 6283.151774510474, 6291.6854157291955, 5970.373110823388, 6032.698365081728, 6100.944524685144, 6117.0, 6126.908096378558, 6119.602225855305, 6168.0, 6193.411625895533, 6204.441600255998, 6208.751649933952, 6081.726322315506, 6129.938700612936, 6143.232095988002, 6144.41628045335, 6152.477039451696, 6080.726367313393, 6089.85156853816, 6135.477655820289, 6143.696113957266, 6170.845728856814, 4887.608991280689, 4888.388951381077, 4898.485659005753, 4902.950970490321, 4905.7301848397965, 4372.672049596293, 4399.20814253431, 4401.031773009932, 4412.227860124465, 4451.910961780811, 5416.539594134464, 5525.4474552545225, 5527.447255274521, 5527.806526771544, 5559.694216818033, 5182.948170518322, 6104.822969073627, 6167.414095660905, 6190.597611155261, 6200.3799620038535, 5467.778982012752, 5512.448755124536, 5537.36320323168, 5586.0, 5621.15682647598, 5332.786688532416, 5336.573074154058, 5342.545883599938, 5350.063738845686, 5373.194020896896, 6266.968665156645, 6274.403931626488, 6276.089966954766, 6282.905756413657, 6295.811125666146, 6135.416406698409, 6140.600860944024, 6196.442320191204, 6211.006239001738, 6237.844053898689, 6249.0, 6264.404881536247, 6268.843278918063, 6270.874582508415, 6277.623342599459, 6132.110843927695, 6156.507479401547, 6159.907601386072, 6160.507159427325, 6166.290876549075, 6072.574919755575, 6101.51991978472, 6167.84580385494, 6228.906566401417, 6237.937620623918, 6058.4850287724275, 6069.605475644069, 6086.513078953584, 6091.238595175603, 6123.8469038272615, 5879.882402351844, 6071.301800293023, 6079.452849243589, 6085.574009819447, 6088.665123418077, 5715.457031581993, 5865.94134058654, 5934.495567876779, 5955.731992060454, 5973.283206015306, 5125.461826508312, 6020.668863212565, 6060.363661815446, 6091.634501929899, 6104.11490333908, 5783.479486846204, 5888.352281249145, 5932.991391463375, 5938.376470470538, 5947.1079338099635], "unit": "score", "name": "dojo.html", "value": 5626.253699226977}, {"lowerIsBetter": false, "replicates": [432.32341385731326, 545.9299772446005, 575.6747437697701, 634.0584232414864, 641.0736485778051, 24566.631500527506, 30599.541006884916, 30727.07818765435, 30752.07743767685, 30813.537796933066, 30812.845935770347, 31292.687073129262, 40507.0, 40985.7950710246, 41038.0, 9473.478958657272, 9644.18024467921, 9671.90328096717, 9677.322587418883, 9722.319437639368, 9560.091791279818, 9702.854457183148, 9710.93179750227, 9720.805583888317, 9730.513474326292, 9652.131308182263, 9736.367136136128, 9739.928607853131, 9757.707268781947, 9770.36492627977, 9613.13481786639, 9709.0, 9788.755281117958, 9808.754781130458, 9834.704958851245, 8407.03319118303, 9651.613935442574, 9665.226781857435, 9692.806143877153, 9788.657396991071, 40299.17905746599, 40852.59147408517, 40852.77441676754, 40867.59132408668, 41079.589204108175, 2971.6136902202793, 2991.22228220662, 3126.655538118608, 3227.5804145461175, 3408.6080100788477, 25514.87242563794, 28756.281092972633, 28837.56743648847, 29246.0, 29369.412611747644, 2678.638383818179, 2732.1666891598056, 2763.875625596833, 2771.80597358185, 2851.130405226405, 484944.5752771249, 488354.0, 490411.0, 491226.0, 491292.0, 44606.55393446089, 61829.690851545456, 62126.0, 62352.06471902925, 62431.6878415605, 45125.87185320327, 45373.54626453693, 45432.0, 45474.77262613732, 45593.77203113963, 15356.769648455282, 15538.766918496232, 15540.378384864705, 15541.067535947654, 15549.766753498707, 12467.127301089018, 12543.12198146121, 12574.371281435891, 12578.433970471167, 12591.811122833165, 14388.784168237486, 14401.495947641992, 14519.78220326696, 14533.418663253351, 14623.78064329036, 5603.991281569275, 6157.783198048699, 6264.436200741864, 6415.486761059104, 6421.743130274736, 930.8603709443638, 986.4574484033752, 988.649029594498, 1025.8461230815437, 1090.6946055104584, 27345.86327068352, 28916.710832891822, 29227.0, 29443.263918402212, 29892.70107298899, 959.1703176752059, 1104.9779004420027, 1105.9336439813476, 1110.7167672243688, 1201.1171788735273, 14739.484118055816, 14778.26108694561, 14781.408743650349, 15189.468368607046, 15240.085594864122, 535595.0, 539861.0, 546070.2696486493, 546630.0, 546988.0, 59118.817623648145, 59585.0, 59586.70206649026, 59690.40309596848, 59752.10371844426, 1297.2670441200692, 1323.4110820684896, 1407.9507217247346, 1451.9709605807825, 1473.4253641079988, 22753.407261491535, 29684.851575741985, 29866.10401687953, 29983.834336662407, 30402.087937361914, 49908.750456247486, 50615.746921265156, 51744.0, 51778.22332664938, 51787.48212517826, 489019.0, 504656.0, 504837.0, 505931.6441013551, 506087.0, 28720.994765183954, 33574.32851343008, 34032.65967340394, 34625.480617791254, 34893.0, 43862.0, 43965.560344397425, 44102.0, 44377.33433998428, 44592.55407445884, 35054.824725877224, 36257.81871090628, 36349.27301454009, 36671.449928250564, 37071.44392834056, 35509.82245088758, 35571.0, 35720.64279357173, 36187.0, 36261.09347266339, 27805.721942780314, 31439.84280078585, 36447.453288200166, 36478.4528232082, 37162.628373717, 29812.51215753179, 30676.079717608507, 30827.84586077145, 31857.0, 31948.68051319457, 19526.414207573795, 22754.089836406358, 23961.921713523283, 24205.91073401666, 24700.38249043788], "unit": "score", "name": "ext.html", "value": 18874.71737547123}, {"lowerIsBetter": false, "replicates": [365.9798711070891, 366.92844895245423, 373.71410870683934, 376.555664316107, 377.2022173103886, 19379.515512112186, 20161.39515814526, 20203.0, 20449.488762780937, 20614.38156855293, 19302.32441864535, 19392.321268755597, 19956.30152944647, 20100.592958492874, 20101.79389236647, 5689.886202275962, 5851.0, 5897.52819774417, 5912.290525136968, 5914.970425147868, 4167.416561681367, 4195.916081678364, 4463.152001119777, 5853.61951473155, 6463.7091330890225, 6371.26730426, 6397.456216221603, 6403.455706264973, 6407.455366293871, 6411.230652321728, 6359.523035772289, 6364.109024736541, 6368.044793281022, 6375.203099612549, 6377.489800815923, 3730.7015438764834, 5302.867428314285, 5518.641288316287, 5523.447655234485, 5526.50261476469, 23468.76531234683, 24212.15257465998, 24366.26901192967, 24496.265112046665, 24500.387490312707, 2007.5081605006867, 2203.3389983005195, 2339.508703172336, 2798.118592643311, 2802.3274414140665, 11504.884951150465, 14176.29118544079, 14181.0, 14464.71070578593, 14842.886783491282, 1689.7887764029497, 1705.4542546385162, 1736.9044702541355, 1746.2054765081857, 1750.4923572164057, 101020.98979010116, 101078.49460752723, 102892.0, 103745.48127259391, 104178.0, 9547.474888881039, 10621.990910863455, 10783.245172837984, 10851.0, 10936.234463587632, 11922.701932451584, 12976.63745306748, 13507.459701611826, 13535.120217185851, 13566.59300220995, 6656.267810540837, 8329.583520824055, 8356.456830306011, 8358.540280284642, 8431.451955622864, 6905.551139175937, 8412.158784121539, 8428.620712067972, 8442.240198382053, 8539.146085391536, 4307.763073030951, 4330.675199360061, 4356.542563030899, 4385.736855788663, 4397.846075387346, 1552.208373729406, 1790.5255107396551, 1792.919755908472, 1830.7253911913053, 1832.1480511562188, 914.3736540469799, 927.0914503786328, 952.5999080386255, 954.2556805691572, 990.6829814459304, 19051.047447627563, 19731.901340493205, 19828.90085549592, 19865.106070226873, 20043.398698039084, 898.2320116300469, 952.3904700991371, 964.2932010341796, 976.8681228034267, 993.145894530703, 10488.737781555523, 10657.040866322068, 10684.89315106839, 10700.197485188643, 10725.946370268099, 609949.0, 611241.0, 624080.0, 629687.0, 630488.0, 82282.0, 119214.4039279798, 119375.40312298383, 123396.0, 123734.0, 1010.4838951011927, 1018.5263852308713, 1035.6841163445222, 1083.1118482843992, 1083.9024487796137, 17524.386646467312, 17553.736693949344, 18254.0, 18436.631267374847, 18439.53901152428, 53255.0, 53848.80738715098, 54151.18773218326, 54901.72549137389, 56288.87422251614, 74557.2544274572, 75174.49651006839, 76465.0, 76934.0, 77242.0, 7632.8855067175145, 7761.4178936578855, 7812.609369531614, 7876.763697089096, 8109.513429194267, 7005.439564834699, 10654.680359589225, 11421.37182454973, 12304.938475307566, 12591.433385497858, 10191.796164076528, 10647.361158330525, 10790.73023174427, 11001.339919604849, 11065.723356916142, 10661.360318380923, 10695.679129625812, 10735.194860385658, 10783.838242426213, 10893.509792059218, 10863.022327990519, 10924.726881828017, 11261.155413343868, 11268.0, 11281.041111505614, 7559.828226624882, 7690.384769218561, 7692.38460923136, 7718.266764657348, 8051.557164356017, 10420.478976051016, 10647.893521065, 10908.61819836302, 10941.07000904932, 10945.398003109905], "unit": "score", "name": "jquery.html", "value": 9344.560723622471}, {"lowerIsBetter": false, "replicates": [1204.704942187149, 1567.3573834727763, 1593.8645215156712, 1860.8325250727432, 1998.4704053425844, 7856.057273127226, 8647.0, 8844.823103537925, 8881.422707524007, 8881.911180888206, 8520.95739521303, 8785.64857405703, 8785.692500762474, 8786.033536311, 8792.51641159736, 2421.128393778238, 2452.9632055519182, 2453.276283496364, 2453.6074228123503, 2454.2882564056404, 2353.752855950126, 2398.7481314461993, 2400.699912510936, 2403.2910291463972, 2427.672264244331, 2258.706368172135, 2272.8409011369213, 2443.7922776564014, 2482.441450673593, 2486.117428312941, 2446.645236440706, 2452.460458699092, 2466.3094333586623, 2484.8260621756485, 2555.258974897287, 2419.8669073200967, 2470.3824043989002, 2480.8015358771254, 2483.4412257242157, 2492.6385674077155, 7416.703331866719, 8845.734627961107, 8855.911440885573, 8930.86603700945, 8937.73186804397, 5317.494837990384, 5462.0, 5472.671639701631, 5474.808381706661, 5476.17857321401, 3508.3684936711384, 3553.6091029986683, 3633.5276414066, 3637.672609465161, 3668.192997540537, 1023.749181450542, 1045.6288017753664, 1046.1055797293282, 1052.8157572424795, 1058.1746237934424, 11998.940005300004, 12025.917667409887, 12051.096167787451, 12085.758284834254, 12085.912267895843, 4752.5485078917445, 4781.6891902026255, 4784.68899521537, 4844.619283504185, 4857.0, 10120.139788118093, 10147.847782283272, 10158.08577228053, 10159.847602285972, 10163.288569800043, 5471.945280547144, 5475.014497390508, 5475.835724928259, 5478.342598888159, 5478.506934375846, 4059.9594004060173, 4420.58004489573, 4628.976855115703, 4921.163402221631, 4986.626003049786, 3801.467794508771, 3840.0975770693863, 3875.767453952772, 3891.8443262269757, 3903.1608204236227, 1290.9225446473242, 1310.4954592481963, 1314.3165553912104, 1324.3973991833693, 1326.7744483437646, 966.8888077870994, 1000.5397517142051, 1005.2711783956573, 1008.4000019988096, 1031.9896801032044, 7955.363570914313, 8081.595920203967, 8086.393520485987, 8090.231428014329, 8094.392920530866, 1108.9611863584896, 1114.7603265298, 1120.9047230985295, 1125.9943700281447, 1157.0685598093448, 6096.786612468631, 6157.076438534255, 6223.906641400383, 6241.656708880964, 6249.218847644044, 10316.742081448025, 10455.954404559483, 10751.19366047534, 10867.130629549618, 10869.45652717361, 10483.0041146091, 10583.206259530412, 10585.259031867849, 10628.309159904582, 10649.094826939798, 7595.278448547379, 8170.060443049007, 8308.584570771438, 8386.538740369217, 8419.494830310201, 7804.414668899742, 7849.60751962411, 7860.882086768817, 7861.724839630586, 7885.2114788520685, 9350.392224505385, 9370.718878433658, 9480.668176614061, 9633.0, 9688.370255933341, 9559.761005974906, 9804.215662747105, 9844.60621575129, 10027.949860250652, 10051.597936082768, 6566.606003639797, 6726.596404215763, 7163.570185788869, 7314.817129571803, 7398.298391370123, 8201.466904651179, 8209.507429554245, 8237.588120594066, 8249.216324449168, 8264.132266111972, 7095.609741464269, 7373.77878663641, 7402.7409040683315, 7512.136104347851, 7570.470067095471, 6360.904586431115, 7100.437903661186, 7208.45936554771, 7312.305330993547, 7362.263773622809, 7629.122650895218, 7734.110577283459, 7735.187805280365, 7740.8451830964195, 7745.109312428917, 6952.895706564506, 6955.234924158237, 7029.332213439715, 7040.1551813780625, 7068.187158476635, 7033.824154395977, 7120.1099862517185, 7135.678894449866, 7151.82120446993, 7169.283071692789], "unit": "score", "name": "mootools.html", "value": 4884.667759594903}, {"lowerIsBetter": false, "replicates": [326.1812849747135, 326.67822195137785, 331.0961076261807, 334.27629182819203, 336.2317105414128, 6364.236291645003, 6385.393387628168, 6403.23161220653, 6419.293877673452, 6421.422072013518, 6238.0642903564485, 6332.7466901324005, 6389.488840892729, 6492.0, 6502.934970650292, 4506.369108324837, 4586.908261834778, 4609.939713865813, 4695.272232803921, 4722.64580156488, 4693.624510039206, 4694.647901407408, 4704.435467743859, 4704.882377940562, 4722.551357621038, 4685.60172385346, 4699.788509517063, 4700.435947686283, 4713.151632706112, 4719.457262414832, 4510.751908645023, 4571.725696458207, 4647.000894807633, 4648.1400940825715, 4675.555822196886, 4034.9394759078637, 4037.6971727120585, 4042.535108462535, 4046.7167298289132, 4050.4126901599398, 4918.434380046269, 6038.18484504595, 6079.240094988127, 6105.603135796159, 6127.11156882254, 5524.779008839641, 5535.529479994165, 5539.169124631298, 5545.889082218373, 5559.833205003856, 6744.93255067448, 6749.0, 6759.7296108155615, 6773.254941956381, 6780.491463140235, 4424.269995450747, 4562.520935301812, 4572.222722137245, 4607.9308810367875, 4609.9308510372375, 7031.718731250744, 7094.1841688206005, 7102.112235970504, 7103.360697537195, 7109.82225444368, 3913.021744563859, 4611.815527378934, 4649.18639238132, 4658.440987081572, 4660.207764680013, 4695.718256904528, 4715.41057367829, 4717.740524271198, 4720.669553131316, 4732.0772449372735, 5501.14732216507, 5502.367227768777, 5509.531689806331, 5522.834314970557, 5540.168974653753, 6368.808935731936, 6378.77674281398, 6739.157605299338, 6788.981652752028, 6825.146856642919, 1549.9460366950357, 1565.2565031609895, 1580.8498192671677, 1585.326236349547, 1585.4292454716292, 951.9714408567754, 970.6020531582018, 1000.5347513406301, 1001.114014097529, 1024.3034736379334, 6110.541709371815, 6238.313785483593, 6243.937560624336, 6253.249610046823, 6262.6868656566985, 7070.39901608369, 7073.363397294268, 7093.32613401726, 7098.077249957472, 7114.71541138359, 6206.348333425016, 6236.18929539157, 6239.78160764371, 6273.435390814849, 6275.937240627535, 3682.1531047859144, 3737.981310093432, 3741.7567858089137, 3743.6069212732814, 3744.85020599173, 6273.905891411632, 7029.118061594721, 7192.352688258082, 7222.349988500955, 7319.8536029280185, 7215.242399548077, 7245.384142347854, 7255.818604534823, 7260.92739072613, 7273.89089163663, 7298.306660867209, 7317.304856038668, 7330.963345183133, 7334.96332518334, 7336.0, 5851.736671849691, 6943.895841562279, 7040.225575186623, 7061.717531298896, 7081.575105493687, 6234.75060997555, 6552.443042341454, 6866.141732283465, 6911.723531058701, 6931.064306318583, 7160.10498687664, 7186.676599552928, 7199.892001620085, 7214.819629509095, 7229.240929702516, 4478.507364189872, 4519.525449827721, 4523.326369243401, 4533.184026875194, 4547.0, 6314.673918477171, 6538.378854008862, 7043.823904402431, 7048.8590228194125, 7088.503804733619, 6481.546291759531, 6726.461883049442, 6732.182310776161, 6847.21257055445, 6847.794566163023, 6723.865522689616, 6779.559328643622, 6787.117674702257, 6790.388865002174, 6800.081988931431, 6636.767713130017, 6645.867082658223, 6668.199816022108, 6669.899951500828, 6671.39957403836, 5494.642848214853, 6792.320767923168, 6794.04883316346, 6795.966020169867, 6796.0, 6374.840628984127, 6644.83387915306, 6652.73389064432, 6661.433778128913, 6688.197416310074], "unit": "score", "name": "prototype.html", "value": 4963.388233750586}, {"lowerIsBetter": false, "replicates": [663.621735610702, 740.1820987808471, 749.8987636669051, 752.356734991582, 761.9123800762907, 12692.936535317322, 15193.240337983098, 16524.25640846163, 16946.576335591617, 17010.40463583775, 15625.921870390632, 15698.37206511738, 15747.370105195807, 15765.975211611238, 15769.684606307866, 732.2604169788499, 886.0652012127204, 911.2300106410073, 913.7030465098869, 917.0829170829171, 728.3372131360463, 905.9048799875984, 918.191991047877, 920.1350730313517, 923.353652443289, 913.5067063785548, 948.5446985446989, 951.0727041134872, 964.1515466389567, 965.1458459263567, 760.9086909570832, 773.8529679360903, 904.2494729374604, 946.356477595235, 950.7670620697938, 572.0675299262217, 705.3722187253348, 707.9327463890974, 714.0681410758957, 714.2179313651543, 15038.849611503854, 15130.016548924285, 15131.167785771779, 15134.167620780963, 15135.318910648937, 12088.09339299556, 12091.214071085351, 12229.571964981273, 12424.56514022005, 12477.812832807514, 9781.41311521311, 9845.901540984642, 9884.0, 10075.798484030352, 10215.080642742114, 2965.4217427601625, 3397.7961322320493, 3426.229098452853, 3464.185916309665, 3538.150843797496, 61391.38608613901, 78790.0, 79510.60244698798, 79553.0, 79562.40875182464, 8231.300339471092, 9114.865603961769, 9197.908020919838, 9237.261019118454, 9259.398139120936, 20442.182312707326, 20894.47763805917, 20915.895420523106, 20932.16271349129, 20997.790022099583, 6188.783392581238, 7215.567065976058, 7322.780316590511, 7376.483646144826, 7409.259074092548, 4051.331530297527, 4114.136031433372, 4116.217918595517, 4118.608732170439, 4137.193247316744, 3506.1234691327168, 3565.2156525564333, 3566.1797786509246, 3568.678818906311, 3600.243948770735, 645.0743183531647, 649.4674367019094, 662.483263054818, 669.6149713914518, 670.3363669966698, 525.9211118332204, 575.1516513143081, 595.76765061626, 602.3344204653882, 610.5756499233079, 8052.235037671412, 8122.918770812216, 8186.754397368089, 8200.343972482187, 8286.668533258602, 519.366373024909, 558.9552835773128, 579.8776478090169, 580.2949416459022, 607.6718571971174, 2825.4914115459005, 3782.149016471327, 3800.1829606634706, 3866.226754649025, 3902.23906338267, 87107.56446217728, 88644.0, 89309.94315767288, 89382.65926011115, 89690.0, 71401.64299178471, 72542.63728681323, 74671.0, 76198.0, 77770.0, 61479.692601536706, 62378.37621623816, 62596.687016564625, 62797.744045119754, 63175.6841215791, 7665.38676905835, 7773.067231931978, 7778.611069446391, 7791.0, 7824.374050075867, 48936.2659560114, 49517.0, 49805.0, 49911.25133122934, 50392.99214015626, 60621.69689151702, 63239.6838015807, 66946.0, 67147.0, 68170.3182968164, 9887.653932112342, 9970.601175952881, 9974.152197063331, 10145.18838492904, 10558.894769893135, 10888.020078193, 10902.073323767569, 11311.925367090113, 11314.208005439541, 11349.602763903224, 10291.125254353165, 10323.122534584343, 10335.638252661121, 10375.0, 10729.46352682347, 10353.275270730977, 10484.842727358942, 10686.198535110054, 10725.141988640735, 10928.071113955402, 10187.134093602126, 10324.48377581103, 10337.0696637303, 10345.275830691779, 10899.128069754242, 7737.883931741141, 7745.92254077452, 8723.011285850285, 9100.863487047833, 9255.35212535116, 8194.42639015287, 8563.100874408346, 8613.82772344537, 8903.910960890309, 9070.138336857988], "unit": "score", "name": "yui.html", "value": 6670.250214169271}], "name": "dromaeo_css", "value": 7371.821232885033}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 109.0, 107.0, 110.0, 109.0, 115.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 141.0, 160.0, 118.0, 144.0, 138.0, 119.0, 165.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 185.0, 185.0, 182.0, 182.0, 184.0, 183.0, 180.0, 219.0], "unit": "score", "name": "audio-dft", "value": 187.0}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 83.0, 82.0, 57.0, 57.0, 58.0, 76.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [95.0, 97.0, 127.0, 78.0, 77.0, 83.0, 116.0, 79.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 88.0, 82.0, 85.0, 74.0, 134.0, 129.0, 87.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 93.0}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 93.0, 92.0, 121.0, 147.0, 98.0, 92.0, 92.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 101.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 110.0, 146.0, 144.0, 84.0, 87.0, 87.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 99.6}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 55.0, 54.0, 53.0, 53.0, 54.0, 63.0, 55.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 76.0, 74.0, 71.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [83.0, 100.0, 110.0, 85.0, 83.0, 92.0, 92.0, 110.0, 110.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 94.8}, {"lowerIsBetter": true, "replicates": [129.0, 123.0, 134.0, 132.0, 119.0, 124.0, 134.0, 135.0, 131.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.8}, {"lowerIsBetter": true, "replicates": [139.0, 130.0, 139.0, 139.0, 139.0, 128.0, 139.0, 141.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 66.0, 68.0, 89.0, 95.0, 96.0, 97.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.0}], "name": "kraken", "value": 1455.5}]} 08:55:19 INFO - Return code: 0 08:55:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:55:19 ERROR - # TBPL SUCCESS # 08:55:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:55:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:55:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:55:19 INFO - 2016-04-06 08:55:19.489 screenresolution[1673:9829] starting screenresolution argv=screenresolution get 08:55:19 INFO - 2016-04-06 08:55:19.492 screenresolution[1673:9829] Display 0: 1600x1200x32@60 08:55:19 INFO - 2016-04-06 08:55:19.498 screenresolution[1674:9833] starting screenresolution argv=screenresolution list 08:55:19 INFO - Available Modes on Display 0 08:55:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:55:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:55:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:55:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:55:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:55:19 INFO - Intel Iris: 08:55:19 INFO - Chipset Model: Intel Iris 08:55:19 INFO - Type: GPU 08:55:19 INFO - Bus: Built-In 08:55:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:55:19 INFO - Vendor: Intel (0x8086) 08:55:19 INFO - Device ID: 0x0a2e 08:55:19 INFO - Revision ID: 0x0009 08:55:19 INFO - Displays: 08:55:19 INFO - Display: 08:55:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:55:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:55:19 INFO - Display Serial Number: 1600x1200 60 08:55:19 INFO - Main Display: Yes 08:55:19 INFO - Mirror: Off 08:55:19 INFO - Online: Yes 08:55:19 INFO - Rotation: Supported 08:55:19 INFO - Return code: 0 08:55:19 INFO - Running post-action listener: _resource_record_post_action 08:55:19 INFO - Running post-run listener: _resource_record_post_run 08:55:20 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 37656064; Write bytes: 691155968; Read time: 394; Write time: 1919 08:55:20 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 395604480; Write bytes: 384361984; Read time: 28578; Write time: 675 08:55:20 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30526976; Write bytes: 295575040; Read time: 306; Write time: 1212 08:55:20 INFO - Running post-run listener: _upload_blobber_files 08:55:20 INFO - Blob upload gear active. 08:55:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:55:20 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 08:55:20 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'] 08:55:20 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 08:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:22 INFO - (blobuploader) - INFO - Done attempting. 08:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:55:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:55:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:55:23 INFO - (blobuploader) - INFO - Done attempting. 08:55:23 INFO - (blobuploader) - INFO - Iteration through files over. 08:55:23 INFO - Return code: 0 08:55:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:55:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:55:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da6ca79cf194e02b7ca429ddf64581334e9e14f0ef0fd8860273b877124e66158fc8feef8eb1143febb3109ea54574e021029071b49c48d212faaec18c7523be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93e536e6add2d1e3aa10d9f740aa5a330a668c6c7aaf4bc9f6356e06c7ff0b7581c7402227b3db6e12403f498d6000e637335a4225b7469b5061b1b796a8c8d2"} 08:55:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:55:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:55:23 INFO - Contents: 08:55:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da6ca79cf194e02b7ca429ddf64581334e9e14f0ef0fd8860273b877124e66158fc8feef8eb1143febb3109ea54574e021029071b49c48d212faaec18c7523be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93e536e6add2d1e3aa10d9f740aa5a330a668c6c7aaf4bc9f6356e06c7ff0b7581c7402227b3db6e12403f498d6000e637335a4225b7469b5061b1b796a8c8d2"} 08:55:23 INFO - Running post-run listener: copy_logs_to_upload_dir 08:55:23 INFO - Copying logs to upload dir... 08:55:23 INFO - mkdir: /builds/slave/test/build/upload/logs 08:55:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.814307 ========= master_lag: 1.87 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-06 08:55:25.244046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 08:55:25.245085) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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/da6ca79cf194e02b7ca429ddf64581334e9e14f0ef0fd8860273b877124e66158fc8feef8eb1143febb3109ea54574e021029071b49c48d212faaec18c7523be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93e536e6add2d1e3aa10d9f740aa5a330a668c6c7aaf4bc9f6356e06c7ff0b7581c7402227b3db6e12403f498d6000e637335a4225b7469b5061b1b796a8c8d2"} build_url:https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011264 build_url: 'https://queue.taskcluster.net/v1/task/SdJea2A6Rv2X7CG-Av32yg/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/da6ca79cf194e02b7ca429ddf64581334e9e14f0ef0fd8860273b877124e66158fc8feef8eb1143febb3109ea54574e021029071b49c48d212faaec18c7523be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/93e536e6add2d1e3aa10d9f740aa5a330a668c6c7aaf4bc9f6356e06c7ff0b7581c7402227b3db6e12403f498d6000e637335a4225b7469b5061b1b796a8c8d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 08:55:25.277604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:55:25.277934) ========= 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.1RB5Mul1g4/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.RwnVXTBq1H/Listeners TMPDIR=/var/folders/jf/19plt40543lf16nnblwl7x1c00000w/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.005387 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 08:55:25.333173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 08:55:25.333497) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 08:55:25.334705) ========= ========= Total master_lag: 3.36 =========