builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1458930941.89 results: success (0) buildid: 20160325083832 builduid: 703c5dbd273e4d7a854b9a0ba50a2520 revision: b2dbee5ca727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:41.890758) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:41.891170) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:41.891451) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005916 basedir: '/builds/slave/test' ========= master_lag: 0.40 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.298621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.298942) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.456673) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.457118) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.004655 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.512424) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.512694) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.513035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.513305) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-25 11:35:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-03-25 11:35:42 (45.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124997 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.801454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:42.801776) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.020020 ========= master_lag: 0.42 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:43.244452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 11:35:43.244779) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b2dbee5ca727 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b2dbee5ca727 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-25 11:35:43,317 Setting DEBUG logging. 2016-03-25 11:35:43,317 attempt 1/10 2016-03-25 11:35:43,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b2dbee5ca727?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 11:35:44,403 unpacking tar archive at: mozilla-central-b2dbee5ca727/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335128 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 11:35:44.601981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:44.602282) ========= echo b2dbee5ca727 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2dbee5ca727'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 b2dbee5ca727 program finished with exit code 0 elapsedTime=0.004860 script_repo_revision: 'b2dbee5ca727' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:44.652689) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:44.653040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 11:35:44.666511) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-25 11:35:44.666808) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:35:44 INFO - MultiFileLogger online at 20160325 11:35:44 in /builds/slave/test 11:35:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:35:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:35:44 INFO - {'append_to_log': False, 11:35:44 INFO - 'base_work_dir': '/builds/slave/test', 11:35:44 INFO - 'blob_upload_branch': 'Firefox', 11:35:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:35:44 INFO - 'branch': 'Firefox', 11:35:44 INFO - 'buildbot_json_path': 'buildprops.json', 11:35:44 INFO - 'config_files': ('talos/mac_config.py',), 11:35:44 INFO - 'default_actions': ('clobber', 11:35:44 INFO - 'read-buildbot-config', 11:35:44 INFO - 'download-and-extract', 11:35:44 INFO - 'populate-webroot', 11:35:44 INFO - 'create-virtualenv', 11:35:44 INFO - 'install', 11:35:44 INFO - 'run-tests'), 11:35:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:35:44 INFO - 'download_minidump_stackwalk': True, 11:35:44 INFO - 'download_symbols': 'ondemand', 11:35:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:35:44 INFO - 'tooltool.py': '/tools/tooltool.py', 11:35:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:35:44 INFO - '/tools/misc-python/virtualenv.py')}, 11:35:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:35:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:35:44 INFO - 'installer_path': 'installer.exe', 11:35:44 INFO - 'log_level': 'info', 11:35:44 INFO - 'log_name': 'talos', 11:35:44 INFO - 'log_to_console': True, 11:35:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:35:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:35:44 INFO - 'opt_config_files': (), 11:35:44 INFO - 'pip_index': False, 11:35:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:35:44 INFO - 'cmd': ('bash', 11:35:44 INFO - '-c', 11:35:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:35:44 INFO - 'enabled': True, 11:35:44 INFO - 'halt_on_failure': False, 11:35:44 INFO - 'name': 'check_screen_resolution'},), 11:35:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:35:44 INFO - 'cmd': ('bash', 11:35:44 INFO - '-c', 11:35:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:35:44 INFO - 'enabled': True, 11:35:44 INFO - 'halt_on_failure': False, 11:35:44 INFO - 'name': 'check_screen_resolution'},), 11:35:44 INFO - 'run_cmd_checks_enabled': True, 11:35:44 INFO - 'sps_profile': False, 11:35:44 INFO - 'sps_profile_interval': 0, 11:35:44 INFO - 'suite': 'dromaeojs', 11:35:44 INFO - 'system_bits': '32', 11:35:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:35:44 INFO - 'title': 't-yosemite-r7-0037', 11:35:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:35:44 INFO - 'use_talos_json': True, 11:35:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:35:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:35:44 INFO - 'work_dir': 'build'} 11:35:44 INFO - ##### 11:35:44 INFO - ##### Running clobber step. 11:35:44 INFO - ##### 11:35:44 INFO - Running pre-action listener: _resource_record_pre_action 11:35:44 INFO - Running main action method: clobber 11:35:44 INFO - rmtree: /builds/slave/test/build 11:35:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:35:46 INFO - Running post-action listener: _resource_record_post_action 11:35:46 INFO - ##### 11:35:46 INFO - ##### Running read-buildbot-config step. 11:35:46 INFO - ##### 11:35:46 INFO - Running pre-action listener: _resource_record_pre_action 11:35:46 INFO - Running main action method: read_buildbot_config 11:35:46 INFO - Using buildbot properties: 11:35:46 INFO - { 11:35:46 INFO - "project": "", 11:35:46 INFO - "product": "firefox", 11:35:46 INFO - "script_repo_revision": "production", 11:35:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 11:35:46 INFO - "repository": "", 11:35:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 11:35:46 INFO - "buildid": "20160325083832", 11:35:46 INFO - "stage_platform": "macosx64", 11:35:46 INFO - "basedir": "/builds/slave/test", 11:35:46 INFO - "nightly_build": "True", 11:35:46 INFO - "buildnumber": 185, 11:35:46 INFO - "slavename": "t-yosemite-r7-0037", 11:35:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:35:46 INFO - "platform": "yosemite_r7", 11:35:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:35:46 INFO - "branch": "mozilla-central", 11:35:46 INFO - "repo_path": "mozilla-central", 11:35:46 INFO - "revision": "b2dbee5ca727", 11:35:46 INFO - "pgo_build": "False", 11:35:46 INFO - "builduid": "703c5dbd273e4d7a854b9a0ba50a2520", 11:35:46 INFO - "slavebuilddir": "test" 11:35:46 INFO - } 11:35:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 11:35:46 INFO - Running post-action listener: _resource_record_post_action 11:35:46 INFO - ##### 11:35:46 INFO - ##### Running download-and-extract step. 11:35:46 INFO - ##### 11:35:46 INFO - Running pre-action listener: _resource_record_pre_action 11:35:46 INFO - Running main action method: download_and_extract 11:35:46 INFO - mkdir: /builds/slave/test/build/tests 11:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:35:46 INFO - https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:35:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:35:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 11:35:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:48 INFO - Downloaded 1199 bytes. 11:35:48 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 11:35:48 INFO - Using the following test package requirements: 11:35:48 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:35:48 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 11:35:48 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 11:35:48 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'jsshell-mac.zip'], 11:35:48 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 11:35:48 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 11:35:48 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 11:35:48 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 11:35:48 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 11:35:48 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 11:35:48 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 11:35:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:35: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')]} 11:35:48 INFO - https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:35:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:35:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:35:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:50 INFO - Downloaded 17943647 bytes. 11:35:50 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'] 11:35:50 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 11:35:53 INFO - Return code: 0 11:35:53 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 11:35:53 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')]} 11:35:53 INFO - https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:35:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:35:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 11:35:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:35:57 INFO - Downloaded 17943647 bytes. 11:35:57 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'] 11:35:57 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 11:36:01 INFO - Return code: 0 11:36: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')]} 11:36:01 INFO - https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 11:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:36:02 INFO - Downloaded 10847531 bytes. 11:36:02 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'] 11:36:02 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 11:36:02 INFO - Return code: 0 11:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:02 INFO - https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:36:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:36:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:36:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 11:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KWSvWHyERZujGbZ2zjh4yw/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 11:36:06 INFO - Downloaded 111508952 bytes. 11:36:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:36:06 INFO - mkdir: /builds/slave/test/properties 11:36:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:36:06 INFO - Writing to file /builds/slave/test/properties/build_url 11:36:06 INFO - Contents: 11:36:06 INFO - build_url:https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 11:36:07 INFO - Running post-action listener: _resource_record_post_action 11:36:07 INFO - Running post-action listener: set_extra_try_arguments 11:36:07 INFO - ##### 11:36:07 INFO - ##### Running populate-webroot step. 11:36:07 INFO - ##### 11:36:07 INFO - Running pre-action listener: _resource_record_pre_action 11:36:07 INFO - Running main action method: populate_webroot 11:36:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:36:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:36:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:36:07 INFO - '--tppagecycles', 11:36:07 INFO - '7'], 11:36:07 INFO - 'tests': ['tsvgm']}}, 11:36:07 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:36:07 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:36:07 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:36:07 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:36:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:36:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'tests': ['damp', 'tps']}, 11:36:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['damp', 'tps']}, 11:36:07 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:36:07 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['dromaeo_dom']}, 11:36:07 INFO - 'other': {'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'other_l64': {'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'other_nol64': {'tests': ['a11yr', 11:36:07 INFO - 'ts_paint', 11:36:07 INFO - 'tpaint', 11:36:07 INFO - 'sessionrestore', 11:36:07 INFO - 'sessionrestore_no_auto_restore', 11:36:07 INFO - 'tabpaint']}, 11:36:07 INFO - 'svgr': {'tests': ['tsvgx', 11:36:07 INFO - 'tsvgr_opacity', 11:36:07 INFO - 'tart', 11:36:07 INFO - 'tscrollx', 11:36:07 INFO - 'cart']}, 11:36:07 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['tsvgx', 11:36:07 INFO - 'tsvgr_opacity', 11:36:07 INFO - 'tart', 11:36:07 INFO - 'tscrollx', 11:36:07 INFO - 'cart']}, 11:36:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'tests': ['tp5o']}, 11:36:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'talos_options': ['--e10s'], 11:36:07 INFO - 'tests': ['tp5o']}, 11:36:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'talos_options': ['--xperf_path', 11:36:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:07 INFO - 'tests': ['tp5n']}, 11:36:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:36:07 INFO - 'talos_options': ['--e10s', 11:36:07 INFO - '--xperf_path', 11:36:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:36:07 INFO - 'tests': ['tp5n']}}, 11:36:07 INFO - 'talos.zip': {'path': '', 11:36:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:36:07 INFO - Running post-action listener: _resource_record_post_action 11:36:07 INFO - ##### 11:36:07 INFO - ##### Running create-virtualenv step. 11:36:07 INFO - ##### 11:36:07 INFO - Running pre-action listener: _resource_record_pre_action 11:36:07 INFO - Running main action method: create_virtualenv 11:36:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:36:07 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 11:36:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:36:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:36:07 INFO - Using real prefix '/tools/python27' 11:36:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:36:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:36:11 INFO - Installing pip.................done. 11:36:11 INFO - Return code: 0 11:36:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:11 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 11:36:11 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 11:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:11 INFO - 'HOME': '/Users/cltbld', 11:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:11 INFO - 'LOGNAME': 'cltbld', 11:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:11 INFO - 'MOZ_NO_REMOTE': '1', 11:36:11 INFO - 'NO_EM_RESTART': '1', 11:36:11 INFO - 'PAGER': '/bin/cat', 11:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:11 INFO - 'PWD': '/builds/slave/test', 11:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:11 INFO - 'SHELL': '/bin/bash', 11:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:11 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:11 INFO - 'USER': 'cltbld', 11:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:11 INFO - 'XPC_FLAGS': '0x0', 11:36:11 INFO - 'XPC_SERVICE_NAME': '0', 11:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:11 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 11:36:11 INFO - Cleaning up... 11:36:11 INFO - Return code: 0 11:36:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:11 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:11 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 11:36:11 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 11:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:11 INFO - 'HOME': '/Users/cltbld', 11:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:11 INFO - 'LOGNAME': 'cltbld', 11:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:11 INFO - 'MOZ_NO_REMOTE': '1', 11:36:11 INFO - 'NO_EM_RESTART': '1', 11:36:11 INFO - 'PAGER': '/bin/cat', 11:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:11 INFO - 'PWD': '/builds/slave/test', 11:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:11 INFO - 'SHELL': '/bin/bash', 11:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:11 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:11 INFO - 'USER': 'cltbld', 11:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:11 INFO - 'XPC_FLAGS': '0x0', 11:36:11 INFO - 'XPC_SERVICE_NAME': '0', 11:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:11 INFO - Downloading/unpacking psutil>=0.7.1 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:14 INFO - Installing collected packages: psutil 11:36:14 INFO - Running setup.py install for psutil 11:36:14 INFO - building 'psutil._psutil_osx' extension 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 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 11:36:14 INFO - building 'psutil._psutil_posix' extension 11:36:14 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 11:36:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:36:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:36:14 INFO - ^ 11:36:15 INFO - 1 warning generated. 11:36:15 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 11:36:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:36:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:36:15 INFO - Successfully installed psutil 11:36:15 INFO - Cleaning up... 11:36:15 INFO - Return code: 0 11:36:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:15 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:15 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 11:36:15 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 11:36:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:15 INFO - 'HOME': '/Users/cltbld', 11:36:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:15 INFO - 'LOGNAME': 'cltbld', 11:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:15 INFO - 'MOZ_NO_REMOTE': '1', 11:36:15 INFO - 'NO_EM_RESTART': '1', 11:36:15 INFO - 'PAGER': '/bin/cat', 11:36:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:15 INFO - 'PWD': '/builds/slave/test', 11:36:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:15 INFO - 'SHELL': '/bin/bash', 11:36:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:15 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:15 INFO - 'USER': 'cltbld', 11:36:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:15 INFO - 'XPC_FLAGS': '0x0', 11:36:15 INFO - 'XPC_SERVICE_NAME': '0', 11:36:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:36:15 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 11:36:15 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 11:36:15 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 11:36:15 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 11:36:15 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 11:36:15 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 11:36:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:36:18 INFO - Installing collected packages: mozsystemmonitor 11:36:18 INFO - Running setup.py install for mozsystemmonitor 11:36:18 INFO - Successfully installed mozsystemmonitor 11:36:18 INFO - Cleaning up... 11:36:18 INFO - Return code: 0 11:36:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:36:18 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')]} 11:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:18 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')]} 11:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:18 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:18 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 11:36:18 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 11:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:18 INFO - 'HOME': '/Users/cltbld', 11:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:18 INFO - 'LOGNAME': 'cltbld', 11:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:18 INFO - 'MOZ_NO_REMOTE': '1', 11:36:18 INFO - 'NO_EM_RESTART': '1', 11:36:18 INFO - 'PAGER': '/bin/cat', 11:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:18 INFO - 'PWD': '/builds/slave/test', 11:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:18 INFO - 'SHELL': '/bin/bash', 11:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:18 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:18 INFO - 'USER': 'cltbld', 11:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:18 INFO - 'XPC_FLAGS': '0x0', 11:36:18 INFO - 'XPC_SERVICE_NAME': '0', 11:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:18 INFO - Downloading/unpacking blobuploader==1.2.4 11:36:18 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 11:36:18 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 11:36:18 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 11:36:18 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 11:36:18 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 11:36:18 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 11:36:21 INFO - Downloading blobuploader-1.2.4.tar.gz 11:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:36:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:36:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:22 INFO - Downloading docopt-0.6.1.tar.gz 11:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:36:22 INFO - Installing collected packages: blobuploader, requests, docopt 11:36:22 INFO - Running setup.py install for blobuploader 11:36:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:36:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:36:22 INFO - Running setup.py install for requests 11:36:23 INFO - Running setup.py install for docopt 11:36:23 INFO - Successfully installed blobuploader requests docopt 11:36:23 INFO - Cleaning up... 11:36:23 INFO - Return code: 0 11:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:23 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:23 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 11:36:23 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 11:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:23 INFO - 'HOME': '/Users/cltbld', 11:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:23 INFO - 'LOGNAME': 'cltbld', 11:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:23 INFO - 'MOZ_NO_REMOTE': '1', 11:36:23 INFO - 'NO_EM_RESTART': '1', 11:36:23 INFO - 'PAGER': '/bin/cat', 11:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:23 INFO - 'PWD': '/builds/slave/test', 11:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:23 INFO - 'SHELL': '/bin/bash', 11:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:23 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:23 INFO - 'USER': 'cltbld', 11:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:23 INFO - 'XPC_FLAGS': '0x0', 11:36:23 INFO - 'XPC_SERVICE_NAME': '0', 11:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-BopuZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:23 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-16y5Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-zfpe2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aI226h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-_RxJ02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8YlxtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-UkTtNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-viHZJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9GR0Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sWzkjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-RNJoa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:24 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rSsPBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:25 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-xYSaEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:25 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-bFN3z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:25 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-0fZaAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:25 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-A5Emjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:25 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-y1JUTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:36:25 INFO - Running setup.py install for manifestparser 11:36:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:36:25 INFO - Running setup.py install for mozcrash 11:36:25 INFO - Running setup.py install for mozdebug 11:36:26 INFO - Running setup.py install for mozdevice 11:36:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Running setup.py install for mozfile 11:36:26 INFO - Running setup.py install for mozhttpd 11:36:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Running setup.py install for mozinfo 11:36:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Running setup.py install for mozInstall 11:36:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:36:26 INFO - Running setup.py install for mozleak 11:36:26 INFO - Running setup.py install for mozlog 11:36:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Running setup.py install for moznetwork 11:36:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Running setup.py install for mozprocess 11:36:27 INFO - Running setup.py install for mozprofile 11:36:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Running setup.py install for mozrunner 11:36:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:36:27 INFO - Running setup.py install for mozscreenshot 11:36:27 INFO - Running setup.py install for moztest 11:36:28 INFO - Running setup.py install for mozversion 11:36:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:36:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:36:28 INFO - Cleaning up... 11:36:28 INFO - Return code: 0 11:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36: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')]} 11:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36: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')]} 11:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:28 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:28 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 11:36:28 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 11:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:28 INFO - 'HOME': '/Users/cltbld', 11:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:28 INFO - 'LOGNAME': 'cltbld', 11:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:28 INFO - 'MOZ_NO_REMOTE': '1', 11:36:28 INFO - 'NO_EM_RESTART': '1', 11:36:28 INFO - 'PAGER': '/bin/cat', 11:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:28 INFO - 'PWD': '/builds/slave/test', 11:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:28 INFO - 'SHELL': '/bin/bash', 11:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:28 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:28 INFO - 'USER': 'cltbld', 11:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:28 INFO - 'XPC_FLAGS': '0x0', 11:36:28 INFO - 'XPC_SERVICE_NAME': '0', 11:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-cOnaZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:36:28 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)) 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kcF0cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:36:28 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)) 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Zgpzu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:36:28 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)) 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-W78bLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:36:28 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)) 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rY6jc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:36:28 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)) 11:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:36:28 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dmq1H5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-JGhZch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-VoPval-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-yXAWca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-N_4zP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-i9vw4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-WMyZcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ks99rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-FaF589-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:36:29 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)) 11:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:29 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ivo39B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:36:30 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)) 11:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:36:30 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-wZGYsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:36:30 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)) 11:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:36:30 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qVhSgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:36:30 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)) 11:36:30 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)) 11:36:30 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)) 11:36:30 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)) 11:36:30 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)) 11:36:30 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)) 11:36:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:36:30 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 11:36:30 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 11:36:30 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 11:36:30 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 11:36:30 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 11:36:30 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 11:36:32 INFO - Downloading blessings-1.6.tar.gz 11:36:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:36:32 INFO - Installing collected packages: blessings 11:36:32 INFO - Running setup.py install for blessings 11:36:32 INFO - Successfully installed blessings 11:36:32 INFO - Cleaning up... 11:36:32 INFO - Return code: 0 11:36:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:36:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:33 INFO - Reading from file tmpfile_stdout 11:36:33 INFO - Current package versions: 11:36:33 INFO - blessings == 1.6 11:36:33 INFO - blobuploader == 1.2.4 11:36:33 INFO - docopt == 0.6.1 11:36:33 INFO - manifestparser == 1.1 11:36:33 INFO - mozInstall == 1.12 11:36:33 INFO - mozcrash == 0.17 11:36:33 INFO - mozdebug == 0.1 11:36:33 INFO - mozdevice == 0.48 11:36:33 INFO - mozfile == 1.2 11:36:33 INFO - mozhttpd == 0.7 11:36:33 INFO - mozinfo == 0.9 11:36:33 INFO - mozleak == 0.1 11:36:33 INFO - mozlog == 3.1 11:36:33 INFO - moznetwork == 0.27 11:36:33 INFO - mozprocess == 0.22 11:36:33 INFO - mozprofile == 0.28 11:36:33 INFO - mozrunner == 6.11 11:36:33 INFO - mozscreenshot == 0.1 11:36:33 INFO - mozsystemmonitor == 0.0 11:36:33 INFO - moztest == 0.7 11:36:33 INFO - mozversion == 1.4 11:36:33 INFO - psutil == 3.1.1 11:36:33 INFO - requests == 1.2.3 11:36:33 INFO - wsgiref == 0.1.2 11:36:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:33 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:33 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 11:36:33 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 11:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:33 INFO - 'HOME': '/Users/cltbld', 11:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:33 INFO - 'LOGNAME': 'cltbld', 11:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:33 INFO - 'MOZ_NO_REMOTE': '1', 11:36:33 INFO - 'NO_EM_RESTART': '1', 11:36:33 INFO - 'PAGER': '/bin/cat', 11:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:33 INFO - 'PWD': '/builds/slave/test', 11:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:33 INFO - 'SHELL': '/bin/bash', 11:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:33 INFO - 'USER': 'cltbld', 11:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:33 INFO - 'XPC_FLAGS': '0x0', 11:36:33 INFO - 'XPC_SERVICE_NAME': '0', 11:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 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)) 11:36:33 INFO - Cleaning up... 11:36:33 INFO - Return code: 0 11:36:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:33 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:33 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 11:36:33 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 11:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:33 INFO - 'HOME': '/Users/cltbld', 11:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:33 INFO - 'LOGNAME': 'cltbld', 11:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:33 INFO - 'MOZ_NO_REMOTE': '1', 11:36:33 INFO - 'NO_EM_RESTART': '1', 11:36:33 INFO - 'PAGER': '/bin/cat', 11:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:33 INFO - 'PWD': '/builds/slave/test', 11:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:33 INFO - 'SHELL': '/bin/bash', 11:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:33 INFO - 'USER': 'cltbld', 11:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:33 INFO - 'XPC_FLAGS': '0x0', 11:36:33 INFO - 'XPC_SERVICE_NAME': '0', 11:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:33 INFO - Downloading/unpacking jsonschema 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:33 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 11:36:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:36:36 INFO - Downloading/unpacking functools32 (from jsonschema) 11:36:36 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 11:36:36 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 11:36:36 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 11:36:36 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 11:36:36 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 11:36:36 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 11:36:36 INFO - Downloading functools32-3.2.3-2.tar.gz 11:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:36:36 INFO - warning: no files found matching '*.txt' 11:36:36 INFO - no previously-included directories found matching 'build' 11:36:36 INFO - no previously-included directories found matching 'dist' 11:36:36 INFO - no previously-included directories found matching '.git*' 11:36:36 INFO - Installing collected packages: jsonschema, functools32 11:36:36 INFO - Running setup.py install for functools32 11:36:36 INFO - warning: no files found matching '*.txt' 11:36:36 INFO - no previously-included directories found matching 'build' 11:36:36 INFO - no previously-included directories found matching 'dist' 11:36:36 INFO - no previously-included directories found matching '.git*' 11:36:36 INFO - Successfully installed jsonschema functools32 11:36:36 INFO - Cleaning up... 11:36:37 INFO - Return code: 0 11:36:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:36:37 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 0x10e372a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e382420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fae62c8b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, '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.PLiB89CWSr/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.J3JKGwaIRb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 11:36:37 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 11:36:37 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 11:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:36:37 INFO - 'HOME': '/Users/cltbld', 11:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:36:37 INFO - 'LOGNAME': 'cltbld', 11:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:36:37 INFO - 'MOZ_NO_REMOTE': '1', 11:36:37 INFO - 'NO_EM_RESTART': '1', 11:36:37 INFO - 'PAGER': '/bin/cat', 11:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:36:37 INFO - 'PWD': '/builds/slave/test', 11:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:36:37 INFO - 'SHELL': '/bin/bash', 11:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:36:37 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:36:37 INFO - 'USER': 'cltbld', 11:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:36:37 INFO - 'XPC_FLAGS': '0x0', 11:36:37 INFO - 'XPC_SERVICE_NAME': '0', 11:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:36:37 INFO - Downloading/unpacking flake8 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:37 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 11:36:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:36:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:36:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:36:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:36:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:40 INFO - no previously-included directories found matching 'docs/_build' 11:36:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:36:41 INFO - Running setup.py install for pep8 11:36:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:36:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:36:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:36:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:36:41 INFO - no previously-included directories found matching 'docs/_build' 11:36:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:36:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:36:41 INFO - Cleaning up... 11:36:41 INFO - Return code: 0 11:36:41 INFO - Running post-action listener: _resource_record_post_action 11:36:41 INFO - Running post-action listener: _start_resource_monitoring 11:36:41 INFO - Starting resource monitoring. 11:36:41 INFO - ##### 11:36:41 INFO - ##### Running install step. 11:36:41 INFO - ##### 11:36:41 INFO - Running pre-action listener: _resource_record_pre_action 11:36:41 INFO - Running main action method: install 11:36:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:36:41 INFO - Reading from file tmpfile_stdout 11:36:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:36:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:36:41 INFO - Reading from file tmpfile_stdout 11:36:41 INFO - Output received: 11:36:41 INFO - Usage: mozinstall [options] installer 11:36:41 INFO - Options: 11:36:41 INFO - -h, --help show this help message and exit 11:36:41 INFO - -d DEST, --destination=DEST 11:36:41 INFO - Directory to install application into. [default: 11:36:41 INFO - "/builds/slave/test"] 11:36:41 INFO - --app=APP Application being installed. [default: firefox] 11:36:41 INFO - mkdir: /builds/slave/test/build/application 11:36:41 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'] 11:36:41 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 11:37:16 INFO - Reading from file tmpfile_stdout 11:37:16 INFO - Output received: 11:37:16 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 11:37:16 INFO - Running post-action listener: _resource_record_post_action 11:37:16 INFO - ##### 11:37:16 INFO - ##### Running run-tests step. 11:37:16 INFO - ##### 11:37:16 INFO - Running pre-action listener: _resource_record_pre_action 11:37:16 INFO - Running main action method: run_tests 11:37:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:37:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:37:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:37:16 INFO - 2016-03-25 11:37:16.503 screenresolution[1930:14467] starting screenresolution argv=screenresolution get 11:37:16 INFO - 2016-03-25 11:37:16.505 screenresolution[1930:14467] Display 0: 1600x1200x32@60 11:37:16 INFO - 2016-03-25 11:37:16.511 screenresolution[1931:14469] starting screenresolution argv=screenresolution list 11:37:16 INFO - Available Modes on Display 0 11:37:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:37:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:37:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:37:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:37:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:37:16 INFO - Intel Iris: 11:37:16 INFO - Chipset Model: Intel Iris 11:37:16 INFO - Type: GPU 11:37:16 INFO - Bus: Built-In 11:37:16 INFO - VRAM (Dynamic, Max): 1536 MB 11:37:16 INFO - Vendor: Intel (0x8086) 11:37:16 INFO - Device ID: 0x0a2e 11:37:16 INFO - Revision ID: 0x0009 11:37:16 INFO - Displays: 11:37:16 INFO - Display: 11:37:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:37:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:37:16 INFO - Display Serial Number: 1600x1200 60 11:37:16 INFO - Main Display: Yes 11:37:16 INFO - Mirror: Off 11:37:16 INFO - Online: Yes 11:37:16 INFO - Rotation: Supported 11:37:16 INFO - Return code: 0 11:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:37:16 INFO - Python 2.7.3 11:37:16 INFO - Return code: 0 11:37:16 INFO - grabbing minidump binary from tooltool 11:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:37:16 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 0x10e211e00>, '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 0x10e03adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e20cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:37:16 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 11:37:16 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 11:37:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:37:16 INFO - Return code: 0 11:37:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:37:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:37:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:37:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:37:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:37:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:37:18 INFO - Return code: 0 11:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 11:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --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 11:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PLiB89CWSr/Render', 11:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:37:18 INFO - 'HOME': '/Users/cltbld', 11:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:37:18 INFO - 'LOGNAME': 'cltbld', 11:37:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:37:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:37:18 INFO - 'MOZ_NO_REMOTE': '1', 11:37:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:37:18 INFO - 'NO_EM_RESTART': '1', 11:37:18 INFO - 'PAGER': '/bin/cat', 11:37:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:37:18 INFO - 'PWD': '/builds/slave/test', 11:37:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:37:18 INFO - 'SHELL': '/bin/bash', 11:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.J3JKGwaIRb/Listeners', 11:37:18 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 11:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:37:18 INFO - 'USER': 'cltbld', 11:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:37:18 INFO - 'XPC_FLAGS': '0x0', 11:37:18 INFO - 'XPC_SERVICE_NAME': '0', 11:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:37:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--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 11:37:18 INFO - mozversion application_buildid: 20160325083832 11:37:18 INFO - mozversion application_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 11:37:18 INFO - mozversion application_display_name: Nightly 11:37:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:37:18 INFO - mozversion application_name: Firefox 11:37:18 INFO - mozversion application_remotingname: firefox 11:37:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:37:18 INFO - mozversion application_vendor: Mozilla 11:37:18 INFO - mozversion application_version: 48.0a1 11:37:18 INFO - mozversion platform_buildid: 20160325083832 11:37:18 INFO - mozversion platform_changeset: b2dbee5ca727e87bdaeab9ab60fb83df2a9846a2 11:37:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:37:18 INFO - mozversion platform_version: 48.0a1 11:37:18 INFO - using testdate: 1458931038 11:37:18 INFO - actual date: 1458931038 11:37:18 INFO - starting webserver on 'localhost:50869' 11:37:18 INFO - SUITE-START | Running 2 tests 11:37:18 INFO - TEST-START | dromaeo_css 11:37:18 INFO - operating with platform_type : mac_ 11:37:18 INFO - Initialising browser for dromaeo_css test... 11:37:18 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp5haY7m/profile http://localhost:50869/getInfo.html) 11:37:20 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 11:37:20 INFO - PROCESS | 1949 | colorDepth:24 11:37:20 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 11:37:20 INFO - PROCESS | 1949 | __metrics 11:37:20 INFO - PROCESS | 1949 | 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" 11:37:20 ERROR - PROCESS | 1949 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:37:21 INFO - TEST-INFO | 1949: exit 0 11:37:21 INFO - Browser initialized. 11:37:21 INFO - Running cycle 1/1 for dromaeo_css test... 11:37:21 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmp5haY7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:33 INFO - PROCESS | 1953 | RSS: Main: 244371456 11:37:33 INFO - PROCESS | 1953 | 11:38:24 INFO - PROCESS | 1953 | 1458931104422 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] 11:40:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50869/tests/dromaeo/cssquery-ext.html) 11:40:36 INFO - PROCESS | 1953 | RSS: Main: 342679552 11:40:36 INFO - PROCESS | 1953 | 11:43:38 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-ext.html (next: http://localhost:50869/tests/dromaeo/cssquery-jquery.html) 11:43:39 INFO - PROCESS | 1953 | RSS: Main: 372146176 11:43:39 INFO - PROCESS | 1953 | 11:46:41 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50869/tests/dromaeo/cssquery-mootools.html) 11:46:41 INFO - PROCESS | 1953 | RSS: Main: 372588544 11:46:41 INFO - PROCESS | 1953 | 11:49:44 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50869/tests/dromaeo/cssquery-prototype.html) 11:49:44 INFO - PROCESS | 1953 | RSS: Main: 330698752 11:49:44 INFO - PROCESS | 1953 | 11:52:47 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50869/tests/dromaeo/cssquery-yui.html) 11:52:48 INFO - PROCESS | 1953 | RSS: Main: 334626816 11:52:48 INFO - PROCESS | 1953 | 11:55:50 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:50869/tests/dromaeo/cssquery-yui.html (next: http://localhost:50869/tests/dromaeo/cssquery-dojo.html) 11:55:51 INFO - PROCESS | 1953 | RSS: Main: 379621376 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | __start_tp_report 11:55:51 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 11:55:51 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 11:55:51 INFO - PROCESS | 1953 | |i|pagename|runs| 11:55:51 INFO - PROCESS | 1953 | |0;dojo.html;3391.423458012138;3433.0730702710284;3437.6906078452935;3490.144914495948;3511.8244087795606;5521.613487055908;5598.384177740456;5681.772729090837;5692.345380281269;5704.401037891019;5597.608167428281;5786.132080187974;5791.942080579203;5795.913061304083;5835.212246346742;5130.38435387754;5210.218467229908;5226.268322434862;5238.4499627539135;5240.973795131029;5071.746412679351;5290.470952904717;5292.92060619091;5350.973245133769;5411.053065713504;5234.92147617786;5257.053730328539;5259.868503287429;5264.315638966929;5293.285406470135;5094.847154585368;5105.285260063594;5206.531412172884;5212.9739351303;5238.81664141757;5163.251328557376;5170.224466330043;5174.922376164361;5176.974115129438;5192.818251361222;5538.501534861882;5543.168524721284;5596.244506991545;5602.859928501779;5645.463680950304;5381.461853814626;5974.014287642533;6107.358727333611;6138.938610613882;6179.938200617981;6223.190985171898;6247.937520624781;6251.249850018027;6263.843403914893;6277.372262773732;5734.856628584235;5735.7418916148035;5740.225069615591;5746.79886203985;5752.194692743019;6180.598261113013;6183.690815459209;6260.467860231931;6282.528810339243;6290.937090629127;6065.939340606537;6077.9363611367835;6097.676199569375;6097.756089756449;6114.296855861633;6136.386361363828;6171.382861713882;6241.251049873953;6246.187995560548;6255.624662520263;6036.577439579188;6090.451859332681;6139.079138129227;6147.84630384244;6159.630422174594;6184.165137706352;6208.627482351073;6211.596246243979;6219.782307619212;6237;4859.684120532154;4867.148249056401;4869.902601947942;4873.171560834667;4892.706437613754;4282.421873047098;4307.310830267204;4395.7582332972;4415.315626077963;4415.933760993587;5678.233438485834;5678.375378708339;5686.2039314496005;5687.573431992617;5692.829215123553;6191.071339299051;6272.655003974825;6283.7800676976085;6289.056641503811;6301.842453938688;5476.096444086761;5558.471945165284;5602.215689803431;5609.971950140223;5648.237487939158;5342.412334643186;5344.518993290622;5345.518903298722;5363.704996225167;5363.973180134074;6260.186175797117;6263.561550691408;6281.183446152062;6290.0879372491645;6292.370762923762;6067.908981365194;6110.5587591967305;6159.1377207190135;6255.624662520263;6258.0925765762795;6236.968815155895;6259.624422534663;6267.717952692231;6297.244330680164;6299.622022678654;6158.476529494864;6164.321924588381;6168.506519478341;6171.660558669317;6183.876322473436;6057.7879774207695;6060.2424696912885;6107.704691583834;6219.160413344322;6290.46531044848;4727.858164255078;6032.577719559588;6044.184035155197;6049.848753781014;6102.4507794298725;5996.640201587918;6019.939800601938;6021.789237376671;6025.487833534024;6026.337102918587;5672.234248376416;5763.510101641407;5769.567282453749;5842.912356314574;5847.736851841592;5941.732622032106;5994.6403215807195;5995.310539288038;6020.187274717857;6039.63762174271;5847.415258474119;5874.295084589877;5882.176495290748;5906.862866820054;5928.3775203603 11:55:51 INFO - PROCESS | 1953 | |1;ext.html;490.60016086889203;552.941941096185;583.8686295583494;600.5298238005902;633.2527617411456;37690.24619507611;38082.238355232876;38102.61897381029;38205;38277.425838612406;41204.175916481654;41805.37291940623;41810.37284440736;41906.7904660477;42031.369529457006;9303.581338839751;9491.050894910522;9508.144267015967;9514.857277140849;9542.666006689768;9376.8593471098;9525.237980961507;9542.33203675743;9545.761355966122;9561.426314421122;9605.66380176694;9672.129508344247;9678.128968392843;9681.322307438482;9682.564284607175;9571.473568953705;9631.133198012212;9636.469994150319;9639;9653.613855445774;8295.751127466187;9618.615255389775;9620.71137865865;9644.987276335954;9653.22774178064;39567.010824729325;40030.799846000584;40087;40094.39858402126;40257.19485610272;3201.2477067889026;3333.233356328034;3460.4636281376174;3642.453631955201;3932.0563064864514;28073.438531229465;29019.564706529418;29524.70475295241;29673.109806705834;29733.256668583243;2706.1475635174857;2708.9864550677316;2756.4349308391734;2799.2721892308145;2834.3480999370054;483426.5828670869;487122;488220;488540;488823;44740.55259447429;45191;45280.3207951881;45287.09425811465;62797;44569.77715111404;44646;44713.329300060526;44769;44910.10179796386;14906.956513043982;15052.623684407978;15067.321970511353;15085.849141508665;15158.545243642708;11983;12060.819087713691;12071.517139314505;12097.153199275966;12183.147179697336;14504.85495145035;14567.013762178727;14580.489682861049;14580.63548411277;14700.852991470163;5423;6097.3292937776805;6316.178896743486;6347.873042539216;6352.936470635234;885.7431344910033;931.1666058877403;948.7343543807744;985.1478471122571;1006.808706345792;28111.691903684823;28287;28567.714322856922;28709.851605935946;28916.855415722788;1075.1237741240864;1084.8589683341115;1155.8439610652622;1159.9478023488964;1203.6629743671785;12128.757424851454;14531.92734036323;14576;14836;15034.624134396727;514695.42652287247;519921;520453;521963.39018304663;522604;57315.56711082173;57911.420885790605;57959.710201448725;58057.70971145117;58226.43056402641;1321.557278311757;1341.1684755451683;1348.191085348783;1461.6492041909864;1561.7423125184218;25455.490890182464;29683.367414792392;30406.116958888535;30755.53866692046;31139;50451.49548504468;50464.495355047446;50639.24041139312;50941.98116037584;51052.48947510626;370249.1487542545;419257;422444;425053;426294;32810;33114;33190.66809331876;33660.66339336673;33689;44525;44757.65727028195;44823.55176448194;45828.08343833171;46235.537644623124;32912.67087329096;35389.823050885614;37403.625963741106;37550.624493754716;37727;35506.28987420185;36070.639293607775;36155.45766813447;36916.90871006361;37063.629363706015;29349.85325073361;31608.051758447284;36861.44707829331;37515.249695005405;38488.61511384962;31171.688283117786;31278.37443251168;31338.373232535676;31348;31356.686433135375;23252.88373558189;23299.767002330438;23564.293071207892;23901;24221 11:55:51 INFO - PROCESS | 1953 | |2;jquery.html;352.6244549554724;360.96029436761967;366.8789299531154;368.12019273935283;369.9075231192202;18328.633427331446;20285.290014849485;20823;21328.8933555332;21334;19089.618207635875;19238.32665856695;19706.901465492654;19807.801921980776;19822.603547929033;5279.656822306557;5433.755481003364;5485.232067510552;5486.753096110665;5489.533389661883;3986.162905789773;4132.29750942339;5385.946140538604;5735.6271842330325;6015.819525414223;5986.8503287417725;6003.159557661931;6006.45941865232;6018.3078945921125;6018.488428483584;5913.704314784243;6372.776952806676;6509.576877502971;6531.150950376445;6596.703148358288;3805.3721136012523;3989.202159568098;3993.0416699992084;3996.4205190247253;5800.854978625526;12758;13096.410661520255;13375.26436046017;13398;13415.396307166104;2041.8774873507637;2053.897305134752;2061.165228082614;2100.537881666031;2309.376468353535;9577.138057574852;9846.163076138537;9898.257630677655;10234.79530409395;10341.224408169417;1511.5238699809636;1734.748461473092;1759.0589034866414;1765.3909401256674;1860.5720684242565;93298;99552;101429.4785578217;101488;102328.14095763152;10464.691913510811;10954.890451095547;11053.447327633587;11066.34810512529;11220.719482013015;12280.815787763191;13605.659858503419;13663.316834158253;13741.24423156736;13744.457275403882;6057.939420605738;8286.668533258722;8303.750887473385;8391.580420978926;8403.621837017348;8268.710595129261;8269.00771907375;8301.958490207511;8345.833083338299;8349.499030058216;4305.677074219446;4386.473623165177;4419.46966364032;4428.689991700615;4432.822687092545;1733.7572739816435;1797.8112298208762;1801.73874788155;1811.085401872046;1856.6193930244267;788.5662885413115;803.8705618605868;834.3325339728193;935.8362286599818;1004.864343313658;18762.624747504975;19790.406287811387;20411.97940102989;20412.0814563345;20653.967301634857;928.5218112671979;969.0945489676615;1020.5254556631202;1027.111548510533;1028.3624153025173;10435.426051567236;10599.788004239872;10622.256442049136;10656.57373705043;10937;616422.8357716455;620690;637005;642432;643527;66510;67824.98262526066;109758;116732.24901626482;116735.41632291954;1029.8506716526063;1042.8957104289661;1062.8246339354075;1108.8115020446544;1113.4544073404136;17496.82503174952;17714.5571360717;17865.419963238088;17921.551961200552;18152.72770908464;47232.2915156266;47264.23884384284;47626;47732.76133619449;48202.75898620485;52100.739496302274;67862.66068669625;68188;68369.97445038229;68414.97377539241;7431.442641801778;7612.885806712793;7689.730859419893;7766.029246344207;7806.92193078062;11262.887371126184;11981.580644677395;12325.815112773495;12357.629271121881;12421.689457763629;10139.493025348851;10372.844407333745;10646.361218326925;10661.626843060456;10866.836997445203;10396.688099357032;10472.162227021972;10538.525766340379;10655;10804.567817287534;10648.148148148284;10831.67504974852;10941.890581094087;10957.958993895567;11153.051990580892;7386.0767404074495;7413.406927445683;7488.288612581796;7641.656125474478;7837.412194085352;9284;10646.574137034431;10867.891321087005;10943;11255.380954047278 11:55:51 INFO - PROCESS | 1953 | |3;mootools.html;1420.28275720761;1578.3370984186643;1598.4085888221357;1849.3249963763221;1871.157978909491;7814.218578142183;8244.34045276378;8404.747857564284;8413.368997325195;8434.873476897843;8335.874961875577;8571.528565928871;8583.957080214606;8587;8591.35564832637;2419.395151212201;2440.4508985478215;2441.011390386896;2443.1571107967725;2450.8284420090513;2431.841930274535;2440.1825388494876;2486.266551367351;2486.6643003194517;2496.10140349474;2430.44099857033;2439.9634005489934;2482.044412901028;2485.0184177249976;2486.6021436570154;2437.902483900642;2460.945110832457;2466.2477944227003;2489.2905521926164;2489.850608963468;2413.9619963415726;2452.2152911068465;2460.1635443949144;2460.569400354949;2482.379405148713;8590.87113693295;8653.134686531359;8663.783405414852;8665.43674661145;8666.436681615738;5381.81163659274;5471.179323101527;5476.096444086721;5479.561635069224;5523.2543606613;3473.322702073097;3543.6633519815578;3566.8751593694356;3569.6430356964356;3588.3182195383056;1040.3445829127677;1060.4114716332433;1061.87257529097;1062.2245760594808;1070.1545778834711;9617.509286060671;11588.594399196072;11768.352740599265;11774.941125294405;11810.29138251699;4365.476142862877;4704.247320428715;4833.927491087637;4840.951590484121;4926.926096108561;8959.835221421305;9847.261455390875;10083.445410502347;10152.23858210637;10172.237082218864;5525.889482210333;5531.280933478622;5534.4742249486235;5542.334919809648;5547.306586676666;4397.450318710161;4557.430321209848;4841.370621819141;4936.851894443173;5036.992601479646;3312.6521715220038;3334.849931753077;3908.729662859525;3921.0785465415606;3940.9605903941165;1308.2739079810797;1323.5698398020681;1325.807757875122;1332.2206509192038;1337.1308649377788;991.6083147156977;1002.0230275481348;1015.0407864567912;1017.1354348803458;1023.7594165371132;7979.601019948979;8087.514749115072;8092.3930705197345;8134.186581341818;8165.673373065129;523.5419008367678;1243.3348158735034;1296.6499045257729;1304.9412776425083;1321.9933900330436;6242.282137554149;6305.558610897285;6328.71520781566;6332.588381755171;6337.112804207414;10011.49942502872;10648.307859989076;10753;10753;10758.838617420744;10160.237982151368;10485.633002845016;10558.04977552024;10627.468626568641;10650.627228046982;8179.79550511242;8320.126386729306;8328.125546817619;8387.83224335522;8399.874001889977;7738.4969976951315;7935.365170786208;7941.801454963672;7961.522308661499;8022.719204827803;9060.637574496946;9332.53337333117;9611.423314601147;9649.421034737938;9743.80512389734;9443.858342124737;9520.190783783455;9716.271279653913;9721.076497732704;9813.165880900204;7301.926980730124;7521.924780752122;7915.683372665029;8105.067917189363;8255.793605159919;8289.626966786389;8341.374396920133;8347.749567512985;8357.206065423776;8365.372597055124;7238.420926325986;7259.6370181491775;7331.74338898136;7500.887486687813;7542.2834830691;7189.245129261352;7197.784066478014;7201.279872012757;7259.056322678018;7300.926990730025;7670.8082297943;7863.882041769492;7874.173211812907;7881.211878812073;7888.053433588007;6974.6512674367095;7036.577805331696;7046.260142684944;7111.82220444493;7118.715251389886;7118.323759242864;7185.568865868065;7197.568145911262;7200;7210.747623833141 11:55:51 INFO - PROCESS | 1953 | |4;prototype.html;300.25087406919727;300.5551783360626;326.4890446451304;334.84597085340744;343.90542600784767;5381.623286369946;5606.4673855983665;6352.777652782153;6429.453496452796;6631;5357.4106848246665;5865.560082993782;6006.189164462807;6384.489240860732;6490.513211509132;4559.110973360196;4642.930356044662;4643.721376717391;4663.417072865892;4839.395075615548;4722.268048452478;4746.833860814872;4754.66717329787;4764.166270902596;4774.355462012636;3866.729328946975;4713.717176969376;4713.811447542094;4742.383490146276;4758.191107511731;4503.684742068057;4575.931361029588;4692.343071969927;4718.4809670936165;4718.9292160617615;4026.8993275168064;4032.8991775205855;4036.4147198656324;4037.838486460538;4044.3326851069537;6085.995810691231;6114.755409783648;6155.507559395282;6161.106639537287;6176.629402235881;5499.752511137009;5522.475364840334;5528.75120619569;5535.114381698949;5543.863507980855;6833.111695479605;6838.692258848364;6844.691988860513;6854.10896583441;6862.828429289258;4271.893202669927;4459.509453960061;4488.438945131858;4488.8877778055485;4508.188526065307;6755.757236526495;7235.529690570096;7263.164736055315;7273.127224733066;7292.489525733201;4569.943525413577;4571.588557029883;4579.96950686093;4583.679142460062;4589.747563884019;4610.654200934943;4621.79201935907;4649.790759415834;4657.115148121846;4664.696794708333;5477.561795056386;5485.094959331665;5497.45025497455;5502.862428439321;5543.916841247385;6632.1709786276715;6872.862542749117;6906;6917.757878474229;6926.134233220848;1592.7212737770844;1603.871690264776;1607.0759313394844;1611.4198888400167;1611.564877483073;1017.1557607186018;1020.4795554267378;1036.300497164411;1039.9220058495644;1043.045613263855;6194.690265486708;6347.714352854133;6356.203270560938;6464.870702585922;6493.935060649427;5877.588568800228;7175.8564828704175;7217.097862767154;7225.9522369256165;7246.891296630555;5655.4910058094965;6445.291017988017;6453.161089058486;6462.321456247027;6472.35276472349;3139.372125574894;3773.509443772347;3806.0865392305645;3812.5234345706785;3817.961820381761;6612.2726500084955;6856.074429951992;7527.9247207528315;7531.8117047073165;7552.697892084365;7391.113066432063;7394.186639469654;7418.369438597671;7429.145648250413;7442.21856705049;7498.287662672037;7505;7505.774826755206;7517.060367454068;7518.947347371263;7153.105861767279;7160.069191005136;7163.176234733072;7185.928140718735;7187.1734750504365;6815.943528753051;7060.611666358194;7083.822904427225;7089.468289878383;7096;7437.851242975218;7482.363999059923;7482.850342993219;7501.962490187514;7502.737404191045;4576.542345765397;4585.72485650862;4586.0827834432575;4598.103369842848;4604.5165257648805;7140.500164988609;7147.3210045045635;7159.498835081703;7161.928380716126;7175.677094530654;6625.867482650417;6886.208086070166;6924.58452492852;6934.757283495053;6946.8610627788175;6869;6874.690638921161;6883.070785443901;6897.310268973062;6899.517033807585;6712.060311556288;6713.295104014008;6714.630695311805;6739.224989126314;6740.865182696417;6873.725050997904;6881.311868813079;6889.965550172217;6892.172939247323;6904.3095690432565;6426.196725409324;6505.154329937078;6616.569922954993;6655.134832471747;6747.730090796314 11:55:51 INFO - PROCESS | 1953 | |5;yui.html;687.6561719140431;749.0823740917374;756.772968109567;767.8464307138573;769.0924708843562;14776.926115369422;14881.851181488168;14972.32624531896;14982.850171498281;14989.550313490585;12774.808377874317;12976.221426714405;13084.476620935151;13098;13112.147710398818;712.6401167410451;722.2488611843677;873.283907196101;884.0849720539243;901.3690416708298;891;902.2691619787993;904.3669431398048;906.1210625693067;908.3777612335538;954.3128947158035;956.1394744729729;956.4357029352681;957.6073809738009;963.9614415423374;753.9095308562953;754.9169591344947;758.8975488309063;940.2712897504421;960.1742501448748;695.0651373902093;695.3255342317943;695.3811108113783;703.2299631903059;715.9785206443815;14769.852301477062;14836.3323650436;14844;14851.480198193012;14903.329350179269;10802.675919722342;12569.057320700893;12711.237325760483;12830.55093071738;12987.02597305206;9864;9891.109800118023;9980.201583873346;10056.69829905104;10751.086157676607;3000.219942814862;3053.328267781085;3584.8386822593047;3585.4621806728937;3586.39031364666;85137;85142.5742871294;85625;86108.56945715295;86593;9280.535973201448;9322.533873306307;9368.2973776967;9592.472414017297;9708.757281067888;21801.890990545264;21857.781422185573;21866.016029278722;21871.890640546695;21878;7249.547902366898;7295.525790823685;7374.778756637309;7393.778186654409;7516.5114267572435;3992.401139829049;4058;4059.6346328830546;4064.7357921734992;4105.815238314283;3611.494390785292;3612.945805812915;3642.9635703643153;3649.489071529988;3649.7445178837756;633.37612451735;635.4725577770439;648.0667838312814;650.2132419772129;657.2113463843407;567.3957235544133;577.4456521739178;598.7604958016829;616.5006344860677;630.7224821078711;7926.207379262143;7986.920130798734;8253.298469630028;8319.084900660922;8521.403501754818;558.0568838662647;585.2976428286074;586.5864565481326;589.5902347868276;604.2024527623582;3743.2887751327708;3815;3824.770513769183;3828.674562662205;3877.4571559981623;89460.5526972361;93927;95726.52136739272;95923;96776.0322396767;76298.6185069071;76882.6155869217;77258.22741772623;77836.61081694555;78060;67210.66394667995;67324;69054;69297;69505.2623684412;7672.117706463605;7702.114256860533;7910.7231246906085;7988.161243069627;8153.1846815317995;48084;50274;50538.49461505338;50749.49250507448;50961.23558146557;66336;67450;68881.65559172172;69717.65141174261;71122;10998.505067272152;11390.202685811913;11391.715207119889;11403.258788178742;11475.885241147816;11677.824832627688;12221.327826969602;12257.448414821532;12352.423170494896;12872.22766634005;7411.814704632212;11502.539898404304;11640.126990475917;11787.705307367041;11903.226290291102;11212.887871121184;11338.886611133783;11476.713082173012;11564.363959981945;11977.461014254206;11420.771584568096;11572.6528204154;11609.941950290195;11734.765304693688;11794.705132371759;9552.90447095548;9817;9872.654457093968;9879.703608891745;9893.35693179941;9444.763880903032;9669.661561845302;9745.853812192681;9797.461139637388;9842.901570984199 11:55:51 INFO - PROCESS | 1953 | __end_tp_report 11:55:51 INFO - PROCESS | 1953 | __start_cc_report 11:55:51 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,1013 11:55:51 INFO - PROCESS | 1953 | __end_cc_report 11:55:51 INFO - PROCESS | 1953 | __startTimestamp1458932151236__endTimestamp 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | ------- Summary: start ------- 11:55:51 INFO - PROCESS | 1953 | Number of tests: 6 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5696.66 Median:5847.74 stddev:621.17 (10.6%) stddev-sans-first:596.17 11:55:51 INFO - PROCESS | 1953 | Values: 3391.4 3433.1 3437.7 3490.1 3511.8 5521.6 5598.4 5681.8 5692.3 5704.4 5597.6 5786.1 5791.9 5795.9 5835.2 5130.4 5210.2 5226.3 5238.4 5241.0 5071.7 5290.5 5292.9 5351.0 5411.1 5234.9 5257.1 5259.9 5264.3 5293.3 5094.8 5105.3 5206.5 5213.0 5238.8 5163.3 5170.2 5174.9 5177.0 5192.8 5538.5 5543.2 5596.2 5602.9 5645.5 5381.5 5974.0 6107.4 6138.9 6179.9 6223.2 6247.9 6251.2 6263.8 6277.4 5734.9 5735.7 5740.2 5746.8 5752.2 6180.6 6183.7 6260.5 6282.5 6290.9 6065.9 6077.9 6097.7 6097.8 6114.3 6136.4 6171.4 6241.3 6246.2 6255.6 6036.6 6090.5 6139.1 6147.8 6159.6 6184.2 6208.6 6211.6 6219.8 6237.0 4859.7 4867.1 4869.9 4873.2 4892.7 4282.4 4307.3 4395.8 4415.3 4415.9 5678.2 5678.4 5686.2 5687.6 5692.8 6191.1 6272.7 6283.8 6289.1 6301.8 5476.1 5558.5 5602.2 5610.0 5648.2 5342.4 5344.5 5345.5 5363.7 5364.0 6260.2 6263.6 6281.2 6290.1 6292.4 6067.9 6110.6 6159.1 6255.6 6258.1 6237.0 6259.6 6267.7 6297.2 6299.6 6158.5 6164.3 6168.5 6171.7 6183.9 6057.8 6060.2 6107.7 6219.2 6290.5 4727.9 6032.6 6044.2 6049.8 6102.5 5996.6 6019.9 6021.8 6025.5 6026.3 5672.2 5763.5 5769.6 5842.9 5847.7 5941.7 5994.6 5995.3 6020.2 6039.6 5847.4 5874.3 5882.2 5906.9 5928.4 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:60823.52 Median:21210.34 stddev:126493.02 (596.4%) stddev-sans-first:126766.76 11:55:51 INFO - PROCESS | 1953 | Values: 490.6 552.9 583.9 600.5 633.3 37690.2 38082.2 38102.6 38205.0 38277.4 41204.2 41805.4 41810.4 41906.8 42031.4 9303.6 9491.1 9508.1 9514.9 9542.7 9376.9 9525.2 9542.3 9545.8 9561.4 9605.7 9672.1 9678.1 9681.3 9682.6 9571.5 9631.1 9636.5 9639.0 9653.6 8295.8 9618.6 9620.7 9645.0 9653.2 39567.0 40030.8 40087.0 40094.4 40257.2 3201.2 3333.2 3460.5 3642.5 3932.1 28073.4 29019.6 29524.7 29673.1 29733.3 2706.1 2709.0 2756.4 2799.3 2834.3 483426.6 487122.0 488220.0 488540.0 488823.0 44740.6 45191.0 45280.3 45287.1 62797.0 44569.8 44646.0 44713.3 44769.0 44910.1 14907.0 15052.6 15067.3 15085.8 15158.5 11983.0 12060.8 12071.5 12097.2 12183.1 14504.9 14567.0 14580.5 14580.6 14700.9 5423.0 6097.3 6316.2 6347.9 6352.9 885.7 931.2 948.7 985.1 1006.8 28111.7 28287.0 28567.7 28709.9 28916.9 1075.1 1084.9 1155.8 1159.9 1203.7 12128.8 14531.9 14576.0 14836.0 15034.6 514695.4 519921.0 520453.0 521963.4 522604.0 57315.6 57911.4 57959.7 58057.7 58226.4 1321.6 1341.2 1348.2 1461.6 1561.7 25455.5 29683.4 30406.1 30755.5 31139.0 50451.5 50464.5 50639.2 50942.0 51052.5 370249.1 419257.0 422444.0 425053.0 426294.0 32810.0 33114.0 33190.7 33660.7 33689.0 44525.0 44757.7 44823.6 45828.1 46235.5 32912.7 35389.8 37403.6 37550.6 37727.0 35506.3 36070.6 36155.5 36916.9 37063.6 29349.9 31608.1 36861.4 37515.2 38488.6 31171.7 31278.4 31338.4 31348.0 31356.7 23252.9 23299.8 23564.3 23901.0 24221.0 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:33398.95 Median:20738.48 stddev:104210.85 (502.5%) stddev-sans-first:104473.64 11:55:51 INFO - PROCESS | 1953 | Values: 352.6 361.0 366.9 368.1 369.9 18328.6 20285.3 20823.0 21328.9 21334.0 19089.6 19238.3 19706.9 19807.8 19822.6 5279.7 5433.8 5485.2 5486.8 5489.5 3986.2 4132.3 5385.9 5735.6 6015.8 5986.9 6003.2 6006.5 6018.3 6018.5 5913.7 6372.8 6509.6 6531.2 6596.7 3805.4 3989.2 3993.0 3996.4 5800.9 12758.0 13096.4 13375.3 13398.0 13415.4 2041.9 2053.9 2061.2 2100.5 2309.4 9577.1 9846.2 9898.3 10234.8 10341.2 1511.5 1734.7 1759.1 1765.4 1860.6 93298.0 99552.0 101429.5 101488.0 102328.1 10464.7 10954.9 11053.4 11066.3 11220.7 12280.8 13605.7 13663.3 13741.2 13744.5 6057.9 8286.7 8303.8 8391.6 8403.6 8268.7 8269.0 8302.0 8345.8 8349.5 4305.7 4386.5 4419.5 4428.7 4432.8 1733.8 1797.8 1801.7 1811.1 1856.6 788.6 803.9 834.3 935.8 1004.9 18762.6 19790.4 20412.0 20412.1 20654.0 928.5 969.1 1020.5 1027.1 1028.4 10435.4 10599.8 10622.3 10656.6 10937.0 616422.8 620690.0 637005.0 642432.0 643527.0 66510.0 67825.0 109758.0 116732.2 116735.4 1029.9 1042.9 1062.8 1108.8 1113.5 17496.8 17714.6 17865.4 17921.6 18152.7 47232.3 47264.2 47626.0 47732.8 48202.8 52100.7 67862.7 68188.0 68370.0 68415.0 7431.4 7612.9 7689.7 7766.0 7806.9 11262.9 11981.6 12325.8 12357.6 12421.7 10139.5 10372.8 10646.4 10661.6 10866.8 10396.7 10472.2 10538.5 10655.0 10804.6 10648.1 10831.7 10941.9 10958.0 11153.1 7386.1 7413.4 7488.3 7641.7 7837.4 9284.0 10646.6 10867.9 10943.0 11255.4 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:6013.92 Median:5524.57 stddev:3139.23 (56.8%) stddev-sans-first:3129.04 11:55:51 INFO - PROCESS | 1953 | Values: 1420.3 1578.3 1598.4 1849.3 1871.2 7814.2 8244.3 8404.7 8413.4 8434.9 8335.9 8571.5 8584.0 8587.0 8591.4 2419.4 2440.5 2441.0 2443.2 2450.8 2431.8 2440.2 2486.3 2486.7 2496.1 2430.4 2440.0 2482.0 2485.0 2486.6 2437.9 2460.9 2466.2 2489.3 2489.9 2414.0 2452.2 2460.2 2460.6 2482.4 8590.9 8653.1 8663.8 8665.4 8666.4 5381.8 5471.2 5476.1 5479.6 5523.3 3473.3 3543.7 3566.9 3569.6 3588.3 1040.3 1060.4 1061.9 1062.2 1070.2 9617.5 11588.6 11768.4 11774.9 11810.3 4365.5 4704.2 4833.9 4841.0 4926.9 8959.8 9847.3 10083.4 10152.2 10172.2 5525.9 5531.3 5534.5 5542.3 5547.3 4397.5 4557.4 4841.4 4936.9 5037.0 3312.7 3334.8 3908.7 3921.1 3941.0 1308.3 1323.6 1325.8 1332.2 1337.1 991.6 1002.0 1015.0 1017.1 1023.8 7979.6 8087.5 8092.4 8134.2 8165.7 523.5 1243.3 1296.6 1304.9 1322.0 6242.3 6305.6 6328.7 6332.6 6337.1 10011.5 10648.3 10753.0 10753.0 10758.8 10160.2 10485.6 10558.0 10627.5 10650.6 8179.8 8320.1 8328.1 8387.8 8399.9 7738.5 7935.4 7941.8 7961.5 8022.7 9060.6 9332.5 9611.4 9649.4 9743.8 9443.9 9520.2 9716.3 9721.1 9813.2 7301.9 7521.9 7915.7 8105.1 8255.8 8289.6 8341.4 8347.7 8357.2 8365.4 7238.4 7259.6 7331.7 7500.9 7542.3 7189.2 7197.8 7201.3 7259.1 7300.9 7670.8 7863.9 7874.2 7881.2 7888.1 6974.7 7036.6 7046.3 7111.8 7118.7 7118.3 7185.6 7197.6 7200.0 7210.7 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:5617.09 Median:6370.35 stddev:1803.13 (28.3%) stddev-sans-first:1763.48 11:55:51 INFO - PROCESS | 1953 | Values: 300.3 300.6 326.5 334.8 343.9 5381.6 5606.5 6352.8 6429.5 6631.0 5357.4 5865.6 6006.2 6384.5 6490.5 4559.1 4642.9 4643.7 4663.4 4839.4 4722.3 4746.8 4754.7 4764.2 4774.4 3866.7 4713.7 4713.8 4742.4 4758.2 4503.7 4575.9 4692.3 4718.5 4718.9 4026.9 4032.9 4036.4 4037.8 4044.3 6086.0 6114.8 6155.5 6161.1 6176.6 5499.8 5522.5 5528.8 5535.1 5543.9 6833.1 6838.7 6844.7 6854.1 6862.8 4271.9 4459.5 4488.4 4488.9 4508.2 6755.8 7235.5 7263.2 7273.1 7292.5 4569.9 4571.6 4580.0 4583.7 4589.7 4610.7 4621.8 4649.8 4657.1 4664.7 5477.6 5485.1 5497.5 5502.9 5543.9 6632.2 6872.9 6906.0 6917.8 6926.1 1592.7 1603.9 1607.1 1611.4 1611.6 1017.2 1020.5 1036.3 1039.9 1043.0 6194.7 6347.7 6356.2 6464.9 6493.9 5877.6 7175.9 7217.1 7226.0 7246.9 5655.5 6445.3 6453.2 6462.3 6472.4 3139.4 3773.5 3806.1 3812.5 3818.0 6612.3 6856.1 7527.9 7531.8 7552.7 7391.1 7394.2 7418.4 7429.1 7442.2 7498.3 7505.0 7505.8 7517.1 7518.9 7153.1 7160.1 7163.2 7185.9 7187.2 6815.9 7060.6 7083.8 7089.5 7096.0 7437.9 7482.4 7482.9 7502.0 7502.7 4576.5 4585.7 4586.1 4598.1 4604.5 7140.5 7147.3 7159.5 7161.9 7175.7 6625.9 6886.2 6924.6 6934.8 6946.9 6869.0 6874.7 6883.1 6897.3 6899.5 6712.1 6713.3 6714.6 6739.2 6740.9 6873.7 6881.3 6890.0 6892.2 6904.3 6426.2 6505.2 6616.6 6655.1 6747.7 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:18428.66 Median:33496.61 stddev:26143.36 (78.0%) stddev-sans-first:26182.76 11:55:51 INFO - PROCESS | 1953 | Values: 687.7 749.1 756.8 767.8 769.1 14776.9 14881.9 14972.3 14982.9 14989.6 12774.8 12976.2 13084.5 13098.0 13112.1 712.6 722.2 873.3 884.1 901.4 891.0 902.3 904.4 906.1 908.4 954.3 956.1 956.4 957.6 964.0 753.9 754.9 758.9 940.3 960.2 695.1 695.3 695.4 703.2 716.0 14769.9 14836.3 14844.0 14851.5 14903.3 10802.7 12569.1 12711.2 12830.6 12987.0 9864.0 9891.1 9980.2 10056.7 10751.1 3000.2 3053.3 3584.8 3585.5 3586.4 85137.0 85142.6 85625.0 86108.6 86593.0 9280.5 9322.5 9368.3 9592.5 9708.8 21801.9 21857.8 21866.0 21871.9 21878.0 7249.5 7295.5 7374.8 7393.8 7516.5 3992.4 4058.0 4059.6 4064.7 4105.8 3611.5 3612.9 3643.0 3649.5 3649.7 633.4 635.5 648.1 650.2 657.2 567.4 577.4 598.8 616.5 630.7 7926.2 7986.9 8253.3 8319.1 8521.4 558.1 585.3 586.6 589.6 604.2 3743.3 3815.0 3824.8 3828.7 3877.5 89460.6 93927.0 95726.5 95923.0 96776.0 76298.6 76882.6 77258.2 77836.6 78060.0 67210.7 67324.0 69054.0 69297.0 69505.3 7672.1 7702.1 7910.7 7988.2 8153.2 48084.0 50274.0 50538.5 50749.5 50961.2 66336.0 67450.0 68881.7 69717.7 71122.0 10998.5 11390.2 11391.7 11403.3 11475.9 11677.8 12221.3 12257.4 12352.4 12872.2 7411.8 11502.5 11640.1 11787.7 11903.2 11212.9 11338.9 11476.7 11564.4 11977.5 11420.8 11572.7 11609.9 11734.8 11794.7 9552.9 9817.0 9872.7 9879.7 9893.4 9444.8 9669.7 9745.9 9797.5 9842.9 11:55:51 INFO - PROCESS | 1953 | -------- Summary: end -------- 11:55:51 INFO - PROCESS | 1953 | 11:55:51 INFO - TEST-INFO | 1953: exit 0 11:55:51 INFO - TEST-OK | dromaeo_css | took 1113584ms 11:55:51 INFO - TEST-START | kraken 11:55:51 INFO - operating with platform_type : mac_ 11:55:51 INFO - Initialising browser for kraken test... 11:55:51 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpY62tYt/profile http://localhost:50869/getInfo.html) 11:55:54 INFO - PROCESS | 1957 | __metrics Screen width/height:1600/1200 11:55:54 INFO - PROCESS | 1957 | colorDepth:24 11:55:54 INFO - PROCESS | 1957 | Browser inner width/height: 1024/689 11:55:54 INFO - PROCESS | 1957 | __metrics 11:55:54 INFO - PROCESS | 1957 | 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" 11:55:54 ERROR - PROCESS | 1957 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:55:54 INFO - TEST-INFO | 1957: exit 0 11:55:54 INFO - Browser initialized. 11:55:54 INFO - Running cycle 1/1 for kraken test... 11:55:54 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpY62tYt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:56:06 INFO - PROCESS | 1960 | RSS: Main: 244371456 11:56:06 INFO - PROCESS | 1960 | 11:56:09 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50869/tests/kraken/driver.html?testName=audio-beat-detection) 11:56:10 INFO - PROCESS | 1960 | RSS: Main: 290844672 11:56:10 INFO - PROCESS | 1960 | 11:56:12 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50869/tests/kraken/driver.html?testName=audio-dft) 11:56:13 INFO - PROCESS | 1960 | RSS: Main: 301363200 11:56:13 INFO - PROCESS | 1960 | 11:56:16 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50869/tests/kraken/driver.html?testName=audio-fft) 11:56:17 INFO - PROCESS | 1960 | RSS: Main: 286470144 11:56:17 INFO - PROCESS | 1960 | 11:56:19 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50869/tests/kraken/driver.html?testName=audio-oscillator) 11:56:19 INFO - PROCESS | 1960 | RSS: Main: 288133120 11:56:19 INFO - PROCESS | 1960 | 11:56:21 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50869/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:56:22 INFO - PROCESS | 1960 | RSS: Main: 288215040 11:56:22 INFO - PROCESS | 1960 | 11:56:25 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50869/tests/kraken/driver.html?testName=imaging-darkroom) 11:56:25 INFO - PROCESS | 1960 | RSS: Main: 288468992 11:56:25 INFO - PROCESS | 1960 | 11:56:28 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50869/tests/kraken/driver.html?testName=imaging-desaturate) 11:56:29 INFO - PROCESS | 1960 | RSS: Main: 288288768 11:56:29 INFO - PROCESS | 1960 | 11:56:31 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50869/tests/kraken/driver.html?testName=json-parse-financial) 11:56:32 INFO - PROCESS | 1960 | RSS: Main: 288854016 11:56:32 INFO - PROCESS | 1960 | 11:56:33 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50869/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:56:34 INFO - PROCESS | 1960 | RSS: Main: 324427776 11:56:34 INFO - PROCESS | 1960 | 11:56:36 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:56:37 INFO - PROCESS | 1960 | RSS: Main: 322859008 11:56:37 INFO - PROCESS | 1960 | 11:56:39 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:56:39 INFO - PROCESS | 1960 | RSS: Main: 331669504 11:56:39 INFO - PROCESS | 1960 | 11:56:42 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:56:42 INFO - PROCESS | 1960 | RSS: Main: 332222464 11:56:42 INFO - PROCESS | 1960 | 11:56:45 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:56:46 INFO - PROCESS | 1960 | RSS: Main: 333631488 11:56:46 INFO - PROCESS | 1960 | 11:56:47 INFO - PROCESS | 1960 | Cycle 1(1): loaded http://localhost:50869/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50869/tests/kraken/driver.html?testName=ai-astar) 11:56:48 INFO - PROCESS | 1960 | RSS: Main: 395091968 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | __start_tp_report 11:56:48 INFO - PROCESS | 1960 | _x_x_mozilla_page_load 11:56:48 INFO - PROCESS | 1960 | _x_x_mozilla_page_load_details 11:56:48 INFO - PROCESS | 1960 | |i|pagename|runs| 11:56:48 INFO - PROCESS | 1960 | |0;ai-astar;111;108;112;112;111;112;118;113;112;111 11:56:48 INFO - PROCESS | 1960 | |1;audio-beat-detection;159;120;145;154;122;141;142;120;162;122 11:56:48 INFO - PROCESS | 1960 | |2;audio-dft;185;189;189;184;185;184;187;184;176;251 11:56:48 INFO - PROCESS | 1960 | |3;audio-fft;74;78;87;80;58;56;59;77;67;55 11:56:48 INFO - PROCESS | 1960 | |4;audio-oscillator;96;94;130;80;79;81;117;79;79;120 11:56:48 INFO - PROCESS | 1960 | |5;imaging-gaussian-blur;87;86;88;84;88;83;88;84;86;84 11:56:48 INFO - PROCESS | 1960 | |6;imaging-darkroom;94;94;95;94;93;94;95;99;98;93 11:56:48 INFO - PROCESS | 1960 | |7;imaging-desaturate;85;86;86;85;82;89;85;85;88;85 11:56:48 INFO - PROCESS | 1960 | |8;json-parse-financial;56;56;56;56;56;56;54;65;56;53 11:56:48 INFO - PROCESS | 1960 | |9;json-stringify-tinderbox;64;68;76;77;72;68;69;70;67;70 11:56:48 INFO - PROCESS | 1960 | |10;stanford-crypto-aes;84;84;83;83;85;82;82;83;85;84 11:56:48 INFO - PROCESS | 1960 | |11;stanford-crypto-ccm;123;133;123;121;126;129;127;119;131;121 11:56:48 INFO - PROCESS | 1960 | |12;stanford-crypto-pbkdf2;168;125;141;138;140;129;140;146;175;177 11:56:48 INFO - PROCESS | 1960 | |13;stanford-crypto-sha256-iterative;68;67;67;67;68;68;67;76;56;61 11:56:48 INFO - PROCESS | 1960 | __end_tp_report 11:56:48 INFO - PROCESS | 1960 | __start_cc_report 11:56:48 INFO - PROCESS | 1960 | _x_x_mozilla_cycle_collect,1291 11:56:48 INFO - PROCESS | 1960 | __end_cc_report 11:56:48 INFO - PROCESS | 1960 | __startTimestamp1458932208079__endTimestamp 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | ------- Summary: start ------- 11:56:48 INFO - PROCESS | 1960 | Number of tests: 14 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:2.62 11:56:48 INFO - PROCESS | 1960 | Values: 111.0 108.0 112.0 112.0 111.0 112.0 118.0 113.0 112.0 111.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:143.50 stddev:16.67 (11.6%) stddev-sans-first:15.99 11:56:48 INFO - PROCESS | 1960 | Values: 159.0 120.0 145.0 154.0 122.0 141.0 142.0 120.0 162.0 122.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#2] audio-dft Cycles:10 Average:191.40 Median:186.00 stddev:21.26 (11.4%) stddev-sans-first:22.42 11:56:48 INFO - PROCESS | 1960 | Values: 185.0 189.0 189.0 184.0 185.0 184.0 187.0 184.0 176.0 251.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#3] audio-fft Cycles:10 Average:69.10 Median:75.50 stddev:11.57 (15.3%) stddev-sans-first:12.14 11:56:48 INFO - PROCESS | 1960 | Values: 74.0 78.0 87.0 80.0 58.0 56.0 59.0 77.0 67.0 55.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.50 stddev:19.78 (24.9%) stddev-sans-first:20.98 11:56:48 INFO - PROCESS | 1960 | Values: 96.0 94.0 130.0 80.0 79.0 81.0 117.0 79.0 79.0 120.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:86.50 stddev:1.93 (2.2%) stddev-sans-first:2.00 11:56:48 INFO - PROCESS | 1960 | Values: 87.0 86.0 88.0 84.0 88.0 83.0 88.0 84.0 86.0 84.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.50 stddev:2.02 (2.1%) stddev-sans-first:2.12 11:56:48 INFO - PROCESS | 1960 | Values: 94.0 94.0 95.0 94.0 93.0 94.0 95.0 99.0 98.0 93.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:85.50 stddev:1.90 (2.2%) stddev-sans-first:2.00 11:56:48 INFO - PROCESS | 1960 | Values: 85.0 86.0 86.0 85.0 82.0 89.0 85.0 85.0 88.0 85.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:3.20 (5.7%) stddev-sans-first:3.40 11:56:48 INFO - PROCESS | 1960 | Values: 56.0 56.0 56.0 56.0 56.0 56.0 54.0 65.0 56.0 53.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.98 (5.7%) stddev-sans-first:3.56 11:56:48 INFO - PROCESS | 1960 | Values: 64.0 68.0 76.0 77.0 72.0 68.0 69.0 70.0 67.0 70.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:1.13 11:56:48 INFO - PROCESS | 1960 | Values: 84.0 84.0 83.0 83.0 85.0 82.0 82.0 83.0 85.0 84.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:126.50 stddev:4.67 (3.7%) stddev-sans-first:4.88 11:56:48 INFO - PROCESS | 1960 | Values: 123.0 133.0 123.0 121.0 126.0 129.0 127.0 119.0 131.0 121.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.90 Median:143.50 stddev:18.68 (13.0%) stddev-sans-first:18.34 11:56:48 INFO - PROCESS | 1960 | Values: 168.0 125.0 141.0 138.0 140.0 129.0 140.0 146.0 175.0 177.0 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - PROCESS | 1960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.50 stddev:5.15 (7.6%) stddev-sans-first:5.43 11:56:48 INFO - PROCESS | 1960 | Values: 68.0 67.0 67.0 67.0 68.0 68.0 67.0 76.0 56.0 61.0 11:56:48 INFO - PROCESS | 1960 | -------- Summary: end -------- 11:56:48 INFO - PROCESS | 1960 | 11:56:48 INFO - TEST-INFO | 1960: exit 0 11:56:48 INFO - TEST-OK | kraken | took 57156ms 11:56:48 INFO - SUITE-END | took 1170s 11:56:49 INFO - Completed test suite (00:19:31) 11:56:49 INFO - javascript benchmark 11:56:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3391.423458012138, 3433.0730702710284, 3437.6906078452935, 3490.144914495948, 3511.8244087795606, 5521.613487055908, 5598.384177740456, 5681.772729090837, 5692.345380281269, 5704.401037891019, 5597.608167428281, 5786.132080187974, 5791.942080579203, 5795.913061304083, 5835.212246346742, 5130.38435387754, 5210.218467229908, 5226.268322434862, 5238.4499627539135, 5240.973795131029, 5071.746412679351, 5290.470952904717, 5292.92060619091, 5350.973245133769, 5411.053065713504, 5234.92147617786, 5257.053730328539, 5259.868503287429, 5264.315638966929, 5293.285406470135, 5094.847154585368, 5105.285260063594, 5206.531412172884, 5212.9739351303, 5238.81664141757, 5163.251328557376, 5170.224466330043, 5174.922376164361, 5176.974115129438, 5192.818251361222, 5538.501534861882, 5543.168524721284, 5596.244506991545, 5602.859928501779, 5645.463680950304, 5381.461853814626, 5974.014287642533, 6107.358727333611, 6138.938610613882, 6179.938200617981, 6223.190985171898, 6247.937520624781, 6251.249850018027, 6263.843403914893, 6277.372262773732, 5734.856628584235, 5735.7418916148035, 5740.225069615591, 5746.79886203985, 5752.194692743019, 6180.598261113013, 6183.690815459209, 6260.467860231931, 6282.528810339243, 6290.937090629127, 6065.939340606537, 6077.9363611367835, 6097.676199569375, 6097.756089756449, 6114.296855861633, 6136.386361363828, 6171.382861713882, 6241.251049873953, 6246.187995560548, 6255.624662520263, 6036.577439579188, 6090.451859332681, 6139.079138129227, 6147.84630384244, 6159.630422174594, 6184.165137706352, 6208.627482351073, 6211.596246243979, 6219.782307619212, 6237.0, 4859.684120532154, 4867.148249056401, 4869.902601947942, 4873.171560834667, 4892.706437613754, 4282.421873047098, 4307.310830267204, 4395.7582332972, 4415.315626077963, 4415.933760993587, 5678.233438485834, 5678.375378708339, 5686.2039314496005, 5687.573431992617, 5692.829215123553, 6191.071339299051, 6272.655003974825, 6283.7800676976085, 6289.056641503811, 6301.842453938688, 5476.096444086761, 5558.471945165284, 5602.215689803431, 5609.971950140223, 5648.237487939158, 5342.412334643186, 5344.518993290622, 5345.518903298722, 5363.704996225167, 5363.973180134074, 6260.186175797117, 6263.561550691408, 6281.183446152062, 6290.0879372491645, 6292.370762923762, 6067.908981365194, 6110.5587591967305, 6159.1377207190135, 6255.624662520263, 6258.0925765762795, 6236.968815155895, 6259.624422534663, 6267.717952692231, 6297.244330680164, 6299.622022678654, 6158.476529494864, 6164.321924588381, 6168.506519478341, 6171.660558669317, 6183.876322473436, 6057.7879774207695, 6060.2424696912885, 6107.704691583834, 6219.160413344322, 6290.46531044848, 4727.858164255078, 6032.577719559588, 6044.184035155197, 6049.848753781014, 6102.4507794298725, 5996.640201587918, 6019.939800601938, 6021.789237376671, 6025.487833534024, 6026.337102918587, 5672.234248376416, 5763.510101641407, 5769.567282453749, 5842.912356314574, 5847.736851841592, 5941.732622032106, 5994.6403215807195, 5995.310539288038, 6020.187274717857, 6039.63762174271, 5847.415258474119, 5874.295084589877, 5882.176495290748, 5906.862866820054, 5928.3775203603], "unit": "score", "name": "dojo.html", "value": 5658.475419384697}, {"lowerIsBetter": false, "replicates": [490.60016086889203, 552.941941096185, 583.8686295583494, 600.5298238005902, 633.2527617411456, 37690.24619507611, 38082.238355232876, 38102.61897381029, 38205.0, 38277.425838612406, 41204.175916481654, 41805.37291940623, 41810.37284440736, 41906.7904660477, 42031.369529457006, 9303.581338839751, 9491.050894910522, 9508.144267015967, 9514.857277140849, 9542.666006689768, 9376.8593471098, 9525.237980961507, 9542.33203675743, 9545.761355966122, 9561.426314421122, 9605.66380176694, 9672.129508344247, 9678.128968392843, 9681.322307438482, 9682.564284607175, 9571.473568953705, 9631.133198012212, 9636.469994150319, 9639.0, 9653.613855445774, 8295.751127466187, 9618.615255389775, 9620.71137865865, 9644.987276335954, 9653.22774178064, 39567.010824729325, 40030.799846000584, 40087.0, 40094.39858402126, 40257.19485610272, 3201.2477067889026, 3333.233356328034, 3460.4636281376174, 3642.453631955201, 3932.0563064864514, 28073.438531229465, 29019.564706529418, 29524.70475295241, 29673.109806705834, 29733.256668583243, 2706.1475635174857, 2708.9864550677316, 2756.4349308391734, 2799.2721892308145, 2834.3480999370054, 483426.5828670869, 487122.0, 488220.0, 488540.0, 488823.0, 44740.55259447429, 45191.0, 45280.3207951881, 45287.09425811465, 62797.0, 44569.77715111404, 44646.0, 44713.329300060526, 44769.0, 44910.10179796386, 14906.956513043982, 15052.623684407978, 15067.321970511353, 15085.849141508665, 15158.545243642708, 11983.0, 12060.819087713691, 12071.517139314505, 12097.153199275966, 12183.147179697336, 14504.85495145035, 14567.013762178727, 14580.489682861049, 14580.63548411277, 14700.852991470163, 5423.0, 6097.3292937776805, 6316.178896743486, 6347.873042539216, 6352.936470635234, 885.7431344910033, 931.1666058877403, 948.7343543807744, 985.1478471122571, 1006.808706345792, 28111.691903684823, 28287.0, 28567.714322856922, 28709.851605935946, 28916.855415722788, 1075.1237741240864, 1084.8589683341115, 1155.8439610652622, 1159.9478023488964, 1203.6629743671785, 12128.757424851454, 14531.92734036323, 14576.0, 14836.0, 15034.624134396727, 514695.42652287247, 519921.0, 520453.0, 521963.39018304663, 522604.0, 57315.56711082173, 57911.420885790605, 57959.710201448725, 58057.70971145117, 58226.43056402641, 1321.557278311757, 1341.1684755451683, 1348.191085348783, 1461.6492041909864, 1561.7423125184218, 25455.490890182464, 29683.367414792392, 30406.116958888535, 30755.53866692046, 31139.0, 50451.49548504468, 50464.495355047446, 50639.24041139312, 50941.98116037584, 51052.48947510626, 370249.1487542545, 419257.0, 422444.0, 425053.0, 426294.0, 32810.0, 33114.0, 33190.66809331876, 33660.66339336673, 33689.0, 44525.0, 44757.65727028195, 44823.55176448194, 45828.08343833171, 46235.537644623124, 32912.67087329096, 35389.823050885614, 37403.625963741106, 37550.624493754716, 37727.0, 35506.28987420185, 36070.639293607775, 36155.45766813447, 36916.90871006361, 37063.629363706015, 29349.85325073361, 31608.051758447284, 36861.44707829331, 37515.249695005405, 38488.61511384962, 31171.688283117786, 31278.37443251168, 31338.373232535676, 31348.0, 31356.686433135375, 23252.88373558189, 23299.767002330438, 23564.293071207892, 23901.0, 24221.0], "unit": "score", "name": "ext.html", "value": 18850.229811068763}, {"lowerIsBetter": false, "replicates": [352.6244549554724, 360.96029436761967, 366.8789299531154, 368.12019273935283, 369.9075231192202, 18328.633427331446, 20285.290014849485, 20823.0, 21328.8933555332, 21334.0, 19089.618207635875, 19238.32665856695, 19706.901465492654, 19807.801921980776, 19822.603547929033, 5279.656822306557, 5433.755481003364, 5485.232067510552, 5486.753096110665, 5489.533389661883, 3986.162905789773, 4132.29750942339, 5385.946140538604, 5735.6271842330325, 6015.819525414223, 5986.8503287417725, 6003.159557661931, 6006.45941865232, 6018.3078945921125, 6018.488428483584, 5913.704314784243, 6372.776952806676, 6509.576877502971, 6531.150950376445, 6596.703148358288, 3805.3721136012523, 3989.202159568098, 3993.0416699992084, 3996.4205190247253, 5800.854978625526, 12758.0, 13096.410661520255, 13375.26436046017, 13398.0, 13415.396307166104, 2041.8774873507637, 2053.897305134752, 2061.165228082614, 2100.537881666031, 2309.376468353535, 9577.138057574852, 9846.163076138537, 9898.257630677655, 10234.79530409395, 10341.224408169417, 1511.5238699809636, 1734.748461473092, 1759.0589034866414, 1765.3909401256674, 1860.5720684242565, 93298.0, 99552.0, 101429.4785578217, 101488.0, 102328.14095763152, 10464.691913510811, 10954.890451095547, 11053.447327633587, 11066.34810512529, 11220.719482013015, 12280.815787763191, 13605.659858503419, 13663.316834158253, 13741.24423156736, 13744.457275403882, 6057.939420605738, 8286.668533258722, 8303.750887473385, 8391.580420978926, 8403.621837017348, 8268.710595129261, 8269.00771907375, 8301.958490207511, 8345.833083338299, 8349.499030058216, 4305.677074219446, 4386.473623165177, 4419.46966364032, 4428.689991700615, 4432.822687092545, 1733.7572739816435, 1797.8112298208762, 1801.73874788155, 1811.085401872046, 1856.6193930244267, 788.5662885413115, 803.8705618605868, 834.3325339728193, 935.8362286599818, 1004.864343313658, 18762.624747504975, 19790.406287811387, 20411.97940102989, 20412.0814563345, 20653.967301634857, 928.5218112671979, 969.0945489676615, 1020.5254556631202, 1027.111548510533, 1028.3624153025173, 10435.426051567236, 10599.788004239872, 10622.256442049136, 10656.57373705043, 10937.0, 616422.8357716455, 620690.0, 637005.0, 642432.0, 643527.0, 66510.0, 67824.98262526066, 109758.0, 116732.24901626482, 116735.41632291954, 1029.8506716526063, 1042.8957104289661, 1062.8246339354075, 1108.8115020446544, 1113.4544073404136, 17496.82503174952, 17714.5571360717, 17865.419963238088, 17921.551961200552, 18152.72770908464, 47232.2915156266, 47264.23884384284, 47626.0, 47732.76133619449, 48202.75898620485, 52100.739496302274, 67862.66068669625, 68188.0, 68369.97445038229, 68414.97377539241, 7431.442641801778, 7612.885806712793, 7689.730859419893, 7766.029246344207, 7806.92193078062, 11262.887371126184, 11981.580644677395, 12325.815112773495, 12357.629271121881, 12421.689457763629, 10139.493025348851, 10372.844407333745, 10646.361218326925, 10661.626843060456, 10866.836997445203, 10396.688099357032, 10472.162227021972, 10538.525766340379, 10655.0, 10804.567817287534, 10648.148148148284, 10831.67504974852, 10941.890581094087, 10957.958993895567, 11153.051990580892, 7386.0767404074495, 7413.406927445683, 7488.288612581796, 7641.656125474478, 7837.412194085352, 9284.0, 10646.574137034431, 10867.891321087005, 10943.0, 11255.380954047278], "unit": "score", "name": "jquery.html", "value": 8888.47867121251}, {"lowerIsBetter": false, "replicates": [1420.28275720761, 1578.3370984186643, 1598.4085888221357, 1849.3249963763221, 1871.157978909491, 7814.218578142183, 8244.34045276378, 8404.747857564284, 8413.368997325195, 8434.873476897843, 8335.874961875577, 8571.528565928871, 8583.957080214606, 8587.0, 8591.35564832637, 2419.395151212201, 2440.4508985478215, 2441.011390386896, 2443.1571107967725, 2450.8284420090513, 2431.841930274535, 2440.1825388494876, 2486.266551367351, 2486.6643003194517, 2496.10140349474, 2430.44099857033, 2439.9634005489934, 2482.044412901028, 2485.0184177249976, 2486.6021436570154, 2437.902483900642, 2460.945110832457, 2466.2477944227003, 2489.2905521926164, 2489.850608963468, 2413.9619963415726, 2452.2152911068465, 2460.1635443949144, 2460.569400354949, 2482.379405148713, 8590.87113693295, 8653.134686531359, 8663.783405414852, 8665.43674661145, 8666.436681615738, 5381.81163659274, 5471.179323101527, 5476.096444086721, 5479.561635069224, 5523.2543606613, 3473.322702073097, 3543.6633519815578, 3566.8751593694356, 3569.6430356964356, 3588.3182195383056, 1040.3445829127677, 1060.4114716332433, 1061.87257529097, 1062.2245760594808, 1070.1545778834711, 9617.509286060671, 11588.594399196072, 11768.352740599265, 11774.941125294405, 11810.29138251699, 4365.476142862877, 4704.247320428715, 4833.927491087637, 4840.951590484121, 4926.926096108561, 8959.835221421305, 9847.261455390875, 10083.445410502347, 10152.23858210637, 10172.237082218864, 5525.889482210333, 5531.280933478622, 5534.4742249486235, 5542.334919809648, 5547.306586676666, 4397.450318710161, 4557.430321209848, 4841.370621819141, 4936.851894443173, 5036.992601479646, 3312.6521715220038, 3334.849931753077, 3908.729662859525, 3921.0785465415606, 3940.9605903941165, 1308.2739079810797, 1323.5698398020681, 1325.807757875122, 1332.2206509192038, 1337.1308649377788, 991.6083147156977, 1002.0230275481348, 1015.0407864567912, 1017.1354348803458, 1023.7594165371132, 7979.601019948979, 8087.514749115072, 8092.3930705197345, 8134.186581341818, 8165.673373065129, 523.5419008367678, 1243.3348158735034, 1296.6499045257729, 1304.9412776425083, 1321.9933900330436, 6242.282137554149, 6305.558610897285, 6328.71520781566, 6332.588381755171, 6337.112804207414, 10011.49942502872, 10648.307859989076, 10753.0, 10753.0, 10758.838617420744, 10160.237982151368, 10485.633002845016, 10558.04977552024, 10627.468626568641, 10650.627228046982, 8179.79550511242, 8320.126386729306, 8328.125546817619, 8387.83224335522, 8399.874001889977, 7738.4969976951315, 7935.365170786208, 7941.801454963672, 7961.522308661499, 8022.719204827803, 9060.637574496946, 9332.53337333117, 9611.423314601147, 9649.421034737938, 9743.80512389734, 9443.858342124737, 9520.190783783455, 9716.271279653913, 9721.076497732704, 9813.165880900204, 7301.926980730124, 7521.924780752122, 7915.683372665029, 8105.067917189363, 8255.793605159919, 8289.626966786389, 8341.374396920133, 8347.749567512985, 8357.206065423776, 8365.372597055124, 7238.420926325986, 7259.6370181491775, 7331.74338898136, 7500.887486687813, 7542.2834830691, 7189.245129261352, 7197.784066478014, 7201.279872012757, 7259.056322678018, 7300.926990730025, 7670.8082297943, 7863.882041769492, 7874.173211812907, 7881.211878812073, 7888.053433588007, 6974.6512674367095, 7036.577805331696, 7046.260142684944, 7111.82220444493, 7118.715251389886, 7118.323759242864, 7185.568865868065, 7197.568145911262, 7200.0, 7210.747623833141], "unit": "score", "name": "mootools.html", "value": 4897.460029982073}, {"lowerIsBetter": false, "replicates": [300.25087406919727, 300.5551783360626, 326.4890446451304, 334.84597085340744, 343.90542600784767, 5381.623286369946, 5606.4673855983665, 6352.777652782153, 6429.453496452796, 6631.0, 5357.4106848246665, 5865.560082993782, 6006.189164462807, 6384.489240860732, 6490.513211509132, 4559.110973360196, 4642.930356044662, 4643.721376717391, 4663.417072865892, 4839.395075615548, 4722.268048452478, 4746.833860814872, 4754.66717329787, 4764.166270902596, 4774.355462012636, 3866.729328946975, 4713.717176969376, 4713.811447542094, 4742.383490146276, 4758.191107511731, 4503.684742068057, 4575.931361029588, 4692.343071969927, 4718.4809670936165, 4718.9292160617615, 4026.8993275168064, 4032.8991775205855, 4036.4147198656324, 4037.838486460538, 4044.3326851069537, 6085.995810691231, 6114.755409783648, 6155.507559395282, 6161.106639537287, 6176.629402235881, 5499.752511137009, 5522.475364840334, 5528.75120619569, 5535.114381698949, 5543.863507980855, 6833.111695479605, 6838.692258848364, 6844.691988860513, 6854.10896583441, 6862.828429289258, 4271.893202669927, 4459.509453960061, 4488.438945131858, 4488.8877778055485, 4508.188526065307, 6755.757236526495, 7235.529690570096, 7263.164736055315, 7273.127224733066, 7292.489525733201, 4569.943525413577, 4571.588557029883, 4579.96950686093, 4583.679142460062, 4589.747563884019, 4610.654200934943, 4621.79201935907, 4649.790759415834, 4657.115148121846, 4664.696794708333, 5477.561795056386, 5485.094959331665, 5497.45025497455, 5502.862428439321, 5543.916841247385, 6632.1709786276715, 6872.862542749117, 6906.0, 6917.757878474229, 6926.134233220848, 1592.7212737770844, 1603.871690264776, 1607.0759313394844, 1611.4198888400167, 1611.564877483073, 1017.1557607186018, 1020.4795554267378, 1036.300497164411, 1039.9220058495644, 1043.045613263855, 6194.690265486708, 6347.714352854133, 6356.203270560938, 6464.870702585922, 6493.935060649427, 5877.588568800228, 7175.8564828704175, 7217.097862767154, 7225.9522369256165, 7246.891296630555, 5655.4910058094965, 6445.291017988017, 6453.161089058486, 6462.321456247027, 6472.35276472349, 3139.372125574894, 3773.509443772347, 3806.0865392305645, 3812.5234345706785, 3817.961820381761, 6612.2726500084955, 6856.074429951992, 7527.9247207528315, 7531.8117047073165, 7552.697892084365, 7391.113066432063, 7394.186639469654, 7418.369438597671, 7429.145648250413, 7442.21856705049, 7498.287662672037, 7505.0, 7505.774826755206, 7517.060367454068, 7518.947347371263, 7153.105861767279, 7160.069191005136, 7163.176234733072, 7185.928140718735, 7187.1734750504365, 6815.943528753051, 7060.611666358194, 7083.822904427225, 7089.468289878383, 7096.0, 7437.851242975218, 7482.363999059923, 7482.850342993219, 7501.962490187514, 7502.737404191045, 4576.542345765397, 4585.72485650862, 4586.0827834432575, 4598.103369842848, 4604.5165257648805, 7140.500164988609, 7147.3210045045635, 7159.498835081703, 7161.928380716126, 7175.677094530654, 6625.867482650417, 6886.208086070166, 6924.58452492852, 6934.757283495053, 6946.8610627788175, 6869.0, 6874.690638921161, 6883.070785443901, 6897.310268973062, 6899.517033807585, 6712.060311556288, 6713.295104014008, 6714.630695311805, 6739.224989126314, 6740.865182696417, 6873.725050997904, 6881.311868813079, 6889.965550172217, 6892.172939247323, 6904.3095690432565, 6426.196725409324, 6505.154329937078, 6616.569922954993, 6655.134832471747, 6747.730090796314], "unit": "score", "name": "prototype.html", "value": 5014.082791736125}, {"lowerIsBetter": false, "replicates": [687.6561719140431, 749.0823740917374, 756.772968109567, 767.8464307138573, 769.0924708843562, 14776.926115369422, 14881.851181488168, 14972.32624531896, 14982.850171498281, 14989.550313490585, 12774.808377874317, 12976.221426714405, 13084.476620935151, 13098.0, 13112.147710398818, 712.6401167410451, 722.2488611843677, 873.283907196101, 884.0849720539243, 901.3690416708298, 891.0, 902.2691619787993, 904.3669431398048, 906.1210625693067, 908.3777612335538, 954.3128947158035, 956.1394744729729, 956.4357029352681, 957.6073809738009, 963.9614415423374, 753.9095308562953, 754.9169591344947, 758.8975488309063, 940.2712897504421, 960.1742501448748, 695.0651373902093, 695.3255342317943, 695.3811108113783, 703.2299631903059, 715.9785206443815, 14769.852301477062, 14836.3323650436, 14844.0, 14851.480198193012, 14903.329350179269, 10802.675919722342, 12569.057320700893, 12711.237325760483, 12830.55093071738, 12987.02597305206, 9864.0, 9891.109800118023, 9980.201583873346, 10056.69829905104, 10751.086157676607, 3000.219942814862, 3053.328267781085, 3584.8386822593047, 3585.4621806728937, 3586.39031364666, 85137.0, 85142.5742871294, 85625.0, 86108.56945715295, 86593.0, 9280.535973201448, 9322.533873306307, 9368.2973776967, 9592.472414017297, 9708.757281067888, 21801.890990545264, 21857.781422185573, 21866.016029278722, 21871.890640546695, 21878.0, 7249.547902366898, 7295.525790823685, 7374.778756637309, 7393.778186654409, 7516.5114267572435, 3992.401139829049, 4058.0, 4059.6346328830546, 4064.7357921734992, 4105.815238314283, 3611.494390785292, 3612.945805812915, 3642.9635703643153, 3649.489071529988, 3649.7445178837756, 633.37612451735, 635.4725577770439, 648.0667838312814, 650.2132419772129, 657.2113463843407, 567.3957235544133, 577.4456521739178, 598.7604958016829, 616.5006344860677, 630.7224821078711, 7926.207379262143, 7986.920130798734, 8253.298469630028, 8319.084900660922, 8521.403501754818, 558.0568838662647, 585.2976428286074, 586.5864565481326, 589.5902347868276, 604.2024527623582, 3743.2887751327708, 3815.0, 3824.770513769183, 3828.674562662205, 3877.4571559981623, 89460.5526972361, 93927.0, 95726.52136739272, 95923.0, 96776.0322396767, 76298.6185069071, 76882.6155869217, 77258.22741772623, 77836.61081694555, 78060.0, 67210.66394667995, 67324.0, 69054.0, 69297.0, 69505.2623684412, 7672.117706463605, 7702.114256860533, 7910.7231246906085, 7988.161243069627, 8153.1846815317995, 48084.0, 50274.0, 50538.49461505338, 50749.49250507448, 50961.23558146557, 66336.0, 67450.0, 68881.65559172172, 69717.65141174261, 71122.0, 10998.505067272152, 11390.202685811913, 11391.715207119889, 11403.258788178742, 11475.885241147816, 11677.824832627688, 12221.327826969602, 12257.448414821532, 12352.423170494896, 12872.22766634005, 7411.814704632212, 11502.539898404304, 11640.126990475917, 11787.705307367041, 11903.226290291102, 11212.887871121184, 11338.886611133783, 11476.713082173012, 11564.363959981945, 11977.461014254206, 11420.771584568096, 11572.6528204154, 11609.941950290195, 11734.765304693688, 11794.705132371759, 9552.90447095548, 9817.0, 9872.654457093968, 9879.703608891745, 9893.35693179941, 9444.763880903032, 9669.661561845302, 9745.853812192681, 9797.461139637388, 9842.901570984199], "unit": "score", "name": "yui.html", "value": 6867.892782189118}], "name": "dromaeo_css", "value": 7367.336116040223}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 108.0, 112.0, 112.0, 111.0, 112.0, 118.0, 113.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 145.0, 154.0, 122.0, 141.0, 142.0, 120.0, 162.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 138.7}, {"lowerIsBetter": true, "replicates": [185.0, 189.0, 189.0, 184.0, 185.0, 184.0, 187.0, 184.0, 176.0, 251.0], "unit": "score", "name": "audio-dft", "value": 191.4}, {"lowerIsBetter": true, "replicates": [74.0, 78.0, 87.0, 80.0, 58.0, 56.0, 59.0, 77.0, 67.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 130.0, 80.0, 79.0, 81.0, 117.0, 79.0, 79.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 95.5}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 84.0, 88.0, 83.0, 88.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 95.0, 99.0, 98.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 94.9}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 85.0, 82.0, 89.0, 85.0, 85.0, 88.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 54.0, 65.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 76.0, 77.0, 72.0, 68.0, 69.0, 70.0, 67.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 83.0, 85.0, 82.0, 82.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [123.0, 133.0, 123.0, 121.0, 126.0, 129.0, 127.0, 119.0, 131.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.3}, {"lowerIsBetter": true, "replicates": [168.0, 125.0, 141.0, 138.0, 140.0, 129.0, 140.0, 146.0, 175.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0, 76.0, 56.0, 61.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1422.7}]} 11:56:49 INFO - Return code: 0 11:56:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:56:49 ERROR - # TBPL SUCCESS # 11:56:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:56:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:56:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:56:49 INFO - 2016-03-25 11:56:49.388 screenresolution[1964:16400] starting screenresolution argv=screenresolution get 11:56:49 INFO - 2016-03-25 11:56:49.391 screenresolution[1964:16400] Display 0: 1600x1200x32@60 11:56:49 INFO - 2016-03-25 11:56:49.397 screenresolution[1965:16403] starting screenresolution argv=screenresolution list 11:56:49 INFO - Available Modes on Display 0 11:56:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:56:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:56:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:56:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:56:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:56:49 INFO - Intel Iris: 11:56:49 INFO - Chipset Model: Intel Iris 11:56:49 INFO - Type: GPU 11:56:49 INFO - Bus: Built-In 11:56:49 INFO - VRAM (Dynamic, Max): 1536 MB 11:56:49 INFO - Vendor: Intel (0x8086) 11:56:49 INFO - Device ID: 0x0a2e 11:56:49 INFO - Revision ID: 0x0009 11:56:49 INFO - Displays: 11:56:49 INFO - Display: 11:56:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:56:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:56:49 INFO - Display Serial Number: 1600x1200 60 11:56:49 INFO - Main Display: Yes 11:56:49 INFO - Mirror: Off 11:56:49 INFO - Online: Yes 11:56:49 INFO - Rotation: Supported 11:56:49 INFO - Return code: 0 11:56:49 INFO - Running post-action listener: _resource_record_post_action 11:56:49 INFO - Running post-run listener: _resource_record_post_run 11:56:50 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2850816; Write bytes: 702852096; Read time: 38; Write time: 1919 11:56:50 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402293248; Write bytes: 397564928; Read time: 31118; Write time: 753 11:56:50 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2850816; Write bytes: 296349696; Read time: 38; Write time: 1133 11:56:50 INFO - Running post-run listener: _upload_blobber_files 11:56:50 INFO - Blob upload gear active. 11:56:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:56:50 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 11:56:50 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:56:50 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:56:51 INFO - (blobuploader) - INFO - Open directory for files ... 11:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:52 INFO - (blobuploader) - INFO - Done attempting. 11:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:56:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:56:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:56:53 INFO - (blobuploader) - INFO - Done attempting. 11:56:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:56:53 INFO - Return code: 0 11:56:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:56:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:56:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11540f40063d7f2b8619d9a9d24ce83a03e3f22b52aad826cdf960133533f4108835dee94df0062d1975727268580988f1f2324ca158c9ca41aef3084f705267", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e629c16de59f678bf421417f1f7309daaca41ad7160fbedf112141e5c7b97b2ce3676cf84d3c904cf1bf61181527ed78e0e2d9fefc9f906fdb80a2636dfb62c"} 11:56:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:56:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:56:53 INFO - Contents: 11:56:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11540f40063d7f2b8619d9a9d24ce83a03e3f22b52aad826cdf960133533f4108835dee94df0062d1975727268580988f1f2324ca158c9ca41aef3084f705267", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e629c16de59f678bf421417f1f7309daaca41ad7160fbedf112141e5c7b97b2ce3676cf84d3c904cf1bf61181527ed78e0e2d9fefc9f906fdb80a2636dfb62c"} 11:56:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:56:53 INFO - Copying logs to upload dir... 11:56:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:56:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.546409 ========= master_lag: 1.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-03-25 11:56:54.522021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 11:56:54.525228) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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/Firefox/sha512/11540f40063d7f2b8619d9a9d24ce83a03e3f22b52aad826cdf960133533f4108835dee94df0062d1975727268580988f1f2324ca158c9ca41aef3084f705267", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e629c16de59f678bf421417f1f7309daaca41ad7160fbedf112141e5c7b97b2ce3676cf84d3c904cf1bf61181527ed78e0e2d9fefc9f906fdb80a2636dfb62c"} build_url:https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011047 build_url: 'https://queue.taskcluster.net/v1/task/KWSvWHyERZujGbZ2zjh4yw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11540f40063d7f2b8619d9a9d24ce83a03e3f22b52aad826cdf960133533f4108835dee94df0062d1975727268580988f1f2324ca158c9ca41aef3084f705267", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e629c16de59f678bf421417f1f7309daaca41ad7160fbedf112141e5c7b97b2ce3676cf84d3c904cf1bf61181527ed78e0e2d9fefc9f906fdb80a2636dfb62c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 11:56:54.564604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:56:54.564928) ========= 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.PLiB89CWSr/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.J3JKGwaIRb/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005090 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 11:56:54.612519) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 11:56:54.612820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 11:56:54.613208) ========= ========= Total master_lag: 2.48 =========