builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0056 starttime: 1459548588.83 results: success (0) buildid: 20160401130352 builduid: 480ae5b80c3e44159dfdf399d7dfb7e4 revision: faa65506b112a63784802378f8fa5610605c96b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.826405) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.826870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.827155) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005426 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.851594) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.851927) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.870323) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.870700) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.918672) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.918988) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.919370) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:48.919654) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-01 15:09:48-- 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% 24.3M=0s 2016-04-01 15:09:49 (24.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.449611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:49.385226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:49.385540) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.025721 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:49.433679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 15:09:49.434041) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev faa65506b112a63784802378f8fa5610605c96b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev faa65506b112a63784802378f8fa5610605c96b0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-01 15:09:49,539 truncating revision to first 12 chars 2016-04-01 15:09:49,539 Setting DEBUG logging. 2016-04-01 15:09:49,539 attempt 1/10 2016-04-01 15:09:49,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/faa65506b112?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 15:09:50,608 unpacking tar archive at: mozilla-aurora-faa65506b112/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309573 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 15:09:50.760438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:50.760789) ========= echo faa65506b112a63784802378f8fa5610605c96b0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'faa65506b112a63784802378f8fa5610605c96b0'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 faa65506b112a63784802378f8fa5610605c96b0 program finished with exit code 0 elapsedTime=0.005265 script_repo_revision: 'faa65506b112a63784802378f8fa5610605c96b0' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:50.810687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:50.811010) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 15:09:50.825150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-04-01 15:09:50.825517) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:09:51 INFO - MultiFileLogger online at 20160401 15:09:51 in /builds/slave/test 15:09:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:09:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:09:51 INFO - {'append_to_log': False, 15:09:51 INFO - 'base_work_dir': '/builds/slave/test', 15:09:51 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:09:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:09:51 INFO - 'branch': 'Mozilla-Aurora', 15:09:51 INFO - 'buildbot_json_path': 'buildprops.json', 15:09:51 INFO - 'config_files': ('talos/mac_config.py',), 15:09:51 INFO - 'default_actions': ('clobber', 15:09:51 INFO - 'read-buildbot-config', 15:09:51 INFO - 'download-and-extract', 15:09:51 INFO - 'populate-webroot', 15:09:51 INFO - 'create-virtualenv', 15:09:51 INFO - 'install', 15:09:51 INFO - 'run-tests'), 15:09:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:09:51 INFO - 'download_minidump_stackwalk': True, 15:09:51 INFO - 'download_symbols': 'ondemand', 15:09:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:09:51 INFO - 'tooltool.py': '/tools/tooltool.py', 15:09:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:09:51 INFO - '/tools/misc-python/virtualenv.py')}, 15:09:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:09:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:09:51 INFO - 'installer_path': 'installer.exe', 15:09:51 INFO - 'log_level': 'info', 15:09:51 INFO - 'log_name': 'talos', 15:09:51 INFO - 'log_to_console': True, 15:09:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:09:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:09:51 INFO - 'opt_config_files': (), 15:09:51 INFO - 'pip_index': False, 15:09:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:09:51 INFO - 'cmd': ('bash', 15:09:51 INFO - '-c', 15:09:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:09:51 INFO - 'enabled': True, 15:09:51 INFO - 'halt_on_failure': False, 15:09:51 INFO - 'name': 'check_screen_resolution'},), 15:09:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:09:51 INFO - 'cmd': ('bash', 15:09:51 INFO - '-c', 15:09:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:09:51 INFO - 'enabled': True, 15:09:51 INFO - 'halt_on_failure': False, 15:09:51 INFO - 'name': 'check_screen_resolution'},), 15:09:51 INFO - 'run_cmd_checks_enabled': True, 15:09:51 INFO - 'sps_profile': False, 15:09:51 INFO - 'sps_profile_interval': 0, 15:09:51 INFO - 'suite': 'dromaeojs', 15:09:51 INFO - 'system_bits': '32', 15:09:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:09:51 INFO - 'title': 't-yosemite-r7-0056', 15:09:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:09:51 INFO - 'use_talos_json': True, 15:09:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:09:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:09:51 INFO - 'work_dir': 'build'} 15:09:51 INFO - ##### 15:09:51 INFO - ##### Running clobber step. 15:09:51 INFO - ##### 15:09:51 INFO - Running pre-action listener: _resource_record_pre_action 15:09:51 INFO - Running main action method: clobber 15:09:51 INFO - rmtree: /builds/slave/test/build 15:09:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:09:53 INFO - Running post-action listener: _resource_record_post_action 15:09:53 INFO - ##### 15:09:53 INFO - ##### Running read-buildbot-config step. 15:09:53 INFO - ##### 15:09:53 INFO - Running pre-action listener: _resource_record_pre_action 15:09:53 INFO - Running main action method: read_buildbot_config 15:09:53 INFO - Using buildbot properties: 15:09:53 INFO - { 15:09:53 INFO - "project": "", 15:09:53 INFO - "product": "firefox", 15:09:53 INFO - "script_repo_revision": "production", 15:09:53 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:09:53 INFO - "repository": "", 15:09:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:09:53 INFO - "buildid": "20160401130352", 15:09:53 INFO - "pgo_build": "False", 15:09:53 INFO - "basedir": "/builds/slave/test", 15:09:53 INFO - "buildnumber": 255, 15:09:53 INFO - "slavename": "t-yosemite-r7-0056", 15:09:53 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:09:53 INFO - "platform": "yosemite_r7", 15:09:53 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:09:53 INFO - "branch": "mozilla-aurora", 15:09:53 INFO - "repo_path": "releases/mozilla-aurora", 15:09:53 INFO - "revision": "faa65506b112a63784802378f8fa5610605c96b0", 15:09:53 INFO - "stage_platform": "macosx64", 15:09:53 INFO - "builduid": "480ae5b80c3e44159dfdf399d7dfb7e4", 15:09:53 INFO - "slavebuilddir": "test" 15:09:53 INFO - } 15:09:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 15:09:53 INFO - Running post-action listener: _resource_record_post_action 15:09:53 INFO - ##### 15:09:53 INFO - ##### Running download-and-extract step. 15:09:53 INFO - ##### 15:09:53 INFO - Running pre-action listener: _resource_record_pre_action 15:09:53 INFO - Running main action method: download_and_extract 15:09:53 INFO - mkdir: /builds/slave/test/build/tests 15:09: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')]} 15:09:53 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:09:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 15:09:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 15:09:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 15:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 15:09:54 INFO - Downloaded 1277 bytes. 15:09:54 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 15:09:54 INFO - Using the following test package requirements: 15:09:54 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:09:54 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 15:09:54 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 15:09:54 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'jsshell-mac.zip'], 15:09:54 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 15:09:54 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:09:54 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 15:09:54 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 15:09:54 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 15:09:54 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 15:09:54 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 15:09:54 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 15:09:54 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:09:54 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:09:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:09:55 INFO - Downloaded 17903479 bytes. 15:09:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:09:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:09:58 INFO - Return code: 0 15:09:58 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:09:58 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')]} 15:09:58 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 15:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:10:00 INFO - Downloaded 17903479 bytes. 15:10:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:10:03 INFO - Return code: 0 15:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:03 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 15:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:10:04 INFO - Downloaded 10845161 bytes. 15:10:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:10:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:10:05 INFO - Return code: 0 15:10:05 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')]} 15:10:05 INFO - https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 15:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 15:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 15:10:08 INFO - Downloaded 115185715 bytes. 15:10:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:08 INFO - mkdir: /builds/slave/test/properties 15:10:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:08 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:08 INFO - Contents: 15:10:08 INFO - build_url:https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 15:10:09 INFO - Running post-action listener: _resource_record_post_action 15:10:09 INFO - Running post-action listener: set_extra_try_arguments 15:10:09 INFO - ##### 15:10:09 INFO - ##### Running populate-webroot step. 15:10:09 INFO - ##### 15:10:09 INFO - Running pre-action listener: _resource_record_pre_action 15:10:09 INFO - Running main action method: populate_webroot 15:10:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:10:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:10:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:10:09 INFO - '--tppagecycles', 15:10:09 INFO - '7'], 15:10:09 INFO - 'tests': ['tsvgm']}}, 15:10:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:10:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:10:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:10:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:10:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'tests': ['damp', 'tps']}, 15:10:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['damp', 'tps']}, 15:10:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:10:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:09 INFO - 'other': {'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'other_l64': {'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'other_nol64': {'tests': ['a11yr', 15:10:09 INFO - 'ts_paint', 15:10:09 INFO - 'tpaint', 15:10:09 INFO - 'sessionrestore', 15:10:09 INFO - 'sessionrestore_no_auto_restore', 15:10:09 INFO - 'tabpaint']}, 15:10:09 INFO - 'svgr': {'tests': ['tsvgx', 15:10:09 INFO - 'tsvgr_opacity', 15:10:09 INFO - 'tart', 15:10:09 INFO - 'tscrollx', 15:10:09 INFO - 'cart']}, 15:10:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['tsvgx', 15:10:09 INFO - 'tsvgr_opacity', 15:10:09 INFO - 'tart', 15:10:09 INFO - 'tscrollx', 15:10:09 INFO - 'cart']}, 15:10:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'tests': ['tp5o']}, 15:10:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'talos_options': ['--e10s'], 15:10:09 INFO - 'tests': ['tp5o']}, 15:10:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'talos_options': ['--xperf_path', 15:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:09 INFO - 'tests': ['tp5n']}, 15:10:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:10:09 INFO - 'talos_options': ['--e10s', 15:10:09 INFO - '--xperf_path', 15:10:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:09 INFO - 'tests': ['tp5n']}}, 15:10:09 INFO - 'talos.zip': {'path': '', 15:10:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:10:09 INFO - Running post-action listener: _resource_record_post_action 15:10:09 INFO - ##### 15:10:09 INFO - ##### Running create-virtualenv step. 15:10:09 INFO - ##### 15:10:09 INFO - Running pre-action listener: _resource_record_pre_action 15:10:09 INFO - Running main action method: create_virtualenv 15:10:09 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:09 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 15:10:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:10:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:09 INFO - Using real prefix '/tools/python27' 15:10:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:10 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:12 INFO - Installing pip.................done. 15:10:12 INFO - Return code: 0 15:10:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:12 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')]} 15:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:12 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')]} 15:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:12 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:12 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 15:10:12 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 15:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:12 INFO - 'HOME': '/Users/cltbld', 15:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:12 INFO - 'LOGNAME': 'cltbld', 15:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:12 INFO - 'MOZ_NO_REMOTE': '1', 15:10:12 INFO - 'NO_EM_RESTART': '1', 15:10:12 INFO - 'PAGER': '/bin/cat', 15:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:12 INFO - 'PWD': '/builds/slave/test', 15:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:12 INFO - 'SHELL': '/bin/bash', 15:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:12 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:12 INFO - 'USER': 'cltbld', 15:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:12 INFO - 'XPC_FLAGS': '0x0', 15:10:12 INFO - 'XPC_SERVICE_NAME': '0', 15:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:13 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 15:10:13 INFO - Cleaning up... 15:10:13 INFO - Return code: 0 15:10:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:10:13 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')]} 15:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:13 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')]} 15:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:13 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:13 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 15:10:13 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 15:10:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:13 INFO - 'HOME': '/Users/cltbld', 15:10:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:13 INFO - 'LOGNAME': 'cltbld', 15:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:13 INFO - 'MOZ_NO_REMOTE': '1', 15:10:13 INFO - 'NO_EM_RESTART': '1', 15:10:13 INFO - 'PAGER': '/bin/cat', 15:10:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:13 INFO - 'PWD': '/builds/slave/test', 15:10:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:13 INFO - 'SHELL': '/bin/bash', 15:10:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:13 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:13 INFO - 'USER': 'cltbld', 15:10:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:13 INFO - 'XPC_FLAGS': '0x0', 15:10:13 INFO - 'XPC_SERVICE_NAME': '0', 15:10:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:13 INFO - Downloading/unpacking psutil>=0.7.1 15:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:15 INFO - Installing collected packages: psutil 15:10:15 INFO - Running setup.py install for psutil 15:10:16 INFO - building 'psutil._psutil_osx' extension 15:10:16 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 15:10:16 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 15:10:16 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 15:10:16 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 15:10:16 INFO - building 'psutil._psutil_posix' extension 15:10:16 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 15:10:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:10:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:10:17 INFO - ^ 15:10:17 INFO - 1 warning generated. 15:10:17 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 15:10:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:17 INFO - Successfully installed psutil 15:10:17 INFO - Cleaning up... 15:10:17 INFO - Return code: 0 15:10:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:10:17 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')]} 15:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:17 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')]} 15:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:17 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:17 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 15:10:17 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 15:10:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:17 INFO - 'HOME': '/Users/cltbld', 15:10:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:17 INFO - 'LOGNAME': 'cltbld', 15:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:17 INFO - 'MOZ_NO_REMOTE': '1', 15:10:17 INFO - 'NO_EM_RESTART': '1', 15:10:17 INFO - 'PAGER': '/bin/cat', 15:10:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:17 INFO - 'PWD': '/builds/slave/test', 15:10:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:17 INFO - 'SHELL': '/bin/bash', 15:10:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:17 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:17 INFO - 'USER': 'cltbld', 15:10:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:17 INFO - 'XPC_FLAGS': '0x0', 15:10:17 INFO - 'XPC_SERVICE_NAME': '0', 15:10:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:10:19 INFO - Installing collected packages: mozsystemmonitor 15:10:19 INFO - Running setup.py install for mozsystemmonitor 15:10:20 INFO - Successfully installed mozsystemmonitor 15:10:20 INFO - Cleaning up... 15:10:20 INFO - Return code: 0 15:10:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:20 INFO - 'HOME': '/Users/cltbld', 15:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:20 INFO - 'LOGNAME': 'cltbld', 15:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:20 INFO - 'MOZ_NO_REMOTE': '1', 15:10:20 INFO - 'NO_EM_RESTART': '1', 15:10:20 INFO - 'PAGER': '/bin/cat', 15:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:20 INFO - 'PWD': '/builds/slave/test', 15:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:20 INFO - 'SHELL': '/bin/bash', 15:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:20 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:20 INFO - 'USER': 'cltbld', 15:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:20 INFO - 'XPC_FLAGS': '0x0', 15:10:20 INFO - 'XPC_SERVICE_NAME': '0', 15:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:20 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:20 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 15:10:20 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 15:10:20 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 15:10:20 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 15:10:20 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 15:10:20 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 15:10:23 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:24 INFO - Downloading docopt-0.6.1.tar.gz 15:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:24 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:24 INFO - Running setup.py install for blobuploader 15:10:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:24 INFO - Running setup.py install for requests 15:10:25 INFO - Running setup.py install for docopt 15:10:25 INFO - Successfully installed blobuploader requests docopt 15:10:25 INFO - Cleaning up... 15:10:25 INFO - Return code: 0 15:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:25 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:25 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 15:10:25 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 15:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:25 INFO - 'HOME': '/Users/cltbld', 15:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:25 INFO - 'LOGNAME': 'cltbld', 15:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:25 INFO - 'MOZ_NO_REMOTE': '1', 15:10:25 INFO - 'NO_EM_RESTART': '1', 15:10:25 INFO - 'PAGER': '/bin/cat', 15:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:25 INFO - 'PWD': '/builds/slave/test', 15:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:25 INFO - 'SHELL': '/bin/bash', 15:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:25 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:25 INFO - 'USER': 'cltbld', 15:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:25 INFO - 'XPC_FLAGS': '0x0', 15:10:25 INFO - 'XPC_SERVICE_NAME': '0', 15:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:25 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-8sExh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:25 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-gFgQC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:25 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-YI2LN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:25 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-1Imbga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:25 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-m26LGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-phWErt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-vaSiGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-Y2viqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-9I7TS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-OrrtJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-WZJiMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-w_c8KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-gpyvAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-WkiuD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:26 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-PhQaE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:27 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-g4n87E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:27 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-SbObr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:27 INFO - Running setup.py install for manifestparser 15:10:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:27 INFO - Running setup.py install for mozcrash 15:10:27 INFO - Running setup.py install for mozdebug 15:10:27 INFO - Running setup.py install for mozdevice 15:10:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:10:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:27 INFO - Running setup.py install for mozfile 15:10:28 INFO - Running setup.py install for mozhttpd 15:10:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Running setup.py install for mozinfo 15:10:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Running setup.py install for mozInstall 15:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Running setup.py install for mozleak 15:10:28 INFO - Running setup.py install for mozlog 15:10:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Running setup.py install for moznetwork 15:10:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:28 INFO - Running setup.py install for mozprocess 15:10:29 INFO - Running setup.py install for mozprofile 15:10:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:29 INFO - Running setup.py install for mozrunner 15:10:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:29 INFO - Running setup.py install for mozscreenshot 15:10:29 INFO - Running setup.py install for moztest 15:10:29 INFO - Running setup.py install for mozversion 15:10:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:29 INFO - Cleaning up... 15:10:29 INFO - Return code: 0 15:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:29 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')]} 15:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:29 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')]} 15:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:29 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:29 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 15:10:29 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 15:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:29 INFO - 'HOME': '/Users/cltbld', 15:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:29 INFO - 'LOGNAME': 'cltbld', 15:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:29 INFO - 'MOZ_NO_REMOTE': '1', 15:10:29 INFO - 'NO_EM_RESTART': '1', 15:10:29 INFO - 'PAGER': '/bin/cat', 15:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:29 INFO - 'PWD': '/builds/slave/test', 15:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:29 INFO - 'SHELL': '/bin/bash', 15:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:29 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:29 INFO - 'USER': 'cltbld', 15:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:29 INFO - 'XPC_FLAGS': '0x0', 15:10:29 INFO - 'XPC_SERVICE_NAME': '0', 15:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-sIejUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-AUhVk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-bJ2lmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-HNKR6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-xaUHTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-lL29rO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-8XCM7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-PTdvh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:30 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)) 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:30 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ImbxqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ib96qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-V0B0Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-qawOx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-ERVnY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-hQ3JlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-lJ3len-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-9lnpMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:31 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)) 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:31 INFO - Running setup.py (path:/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/pip-n2URUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:31 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)) 15:10:31 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)) 15:10:31 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)) 15:10:31 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)) 15:10:31 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)) 15:10:31 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)) 15:10:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:31 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 15:10:31 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 15:10:31 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 15:10:31 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 15:10:31 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 15:10:31 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 15:10:34 INFO - Downloading blessings-1.6.tar.gz 15:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:34 INFO - Installing collected packages: blessings 15:10:34 INFO - Running setup.py install for blessings 15:10:34 INFO - Successfully installed blessings 15:10:34 INFO - Cleaning up... 15:10:34 INFO - Return code: 0 15:10:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:34 INFO - Reading from file tmpfile_stdout 15:10:34 INFO - Current package versions: 15:10:34 INFO - blessings == 1.6 15:10:34 INFO - blobuploader == 1.2.4 15:10:34 INFO - docopt == 0.6.1 15:10:34 INFO - manifestparser == 1.1 15:10:34 INFO - mozInstall == 1.12 15:10:34 INFO - mozcrash == 0.17 15:10:34 INFO - mozdebug == 0.1 15:10:34 INFO - mozdevice == 0.48 15:10:34 INFO - mozfile == 1.2 15:10:34 INFO - mozhttpd == 0.7 15:10:34 INFO - mozinfo == 0.9 15:10:34 INFO - mozleak == 0.1 15:10:34 INFO - mozlog == 3.1 15:10:34 INFO - moznetwork == 0.27 15:10:34 INFO - mozprocess == 0.22 15:10:34 INFO - mozprofile == 0.28 15:10:34 INFO - mozrunner == 6.11 15:10:34 INFO - mozscreenshot == 0.1 15:10:34 INFO - mozsystemmonitor == 0.0 15:10:34 INFO - moztest == 0.7 15:10:34 INFO - mozversion == 1.4 15:10:34 INFO - psutil == 3.1.1 15:10:34 INFO - requests == 1.2.3 15:10:34 INFO - wsgiref == 0.1.2 15:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:34 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:34 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 15:10:34 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 15:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:34 INFO - 'HOME': '/Users/cltbld', 15:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:34 INFO - 'LOGNAME': 'cltbld', 15:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:34 INFO - 'MOZ_NO_REMOTE': '1', 15:10:34 INFO - 'NO_EM_RESTART': '1', 15:10:34 INFO - 'PAGER': '/bin/cat', 15:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:34 INFO - 'PWD': '/builds/slave/test', 15:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:34 INFO - 'SHELL': '/bin/bash', 15:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:34 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:34 INFO - 'USER': 'cltbld', 15:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:34 INFO - 'XPC_FLAGS': '0x0', 15:10:34 INFO - 'XPC_SERVICE_NAME': '0', 15:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 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)) 15:10:35 INFO - Cleaning up... 15:10:35 INFO - Return code: 0 15:10:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:35 INFO - 'HOME': '/Users/cltbld', 15:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:35 INFO - 'LOGNAME': 'cltbld', 15:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:35 INFO - 'MOZ_NO_REMOTE': '1', 15:10:35 INFO - 'NO_EM_RESTART': '1', 15:10:35 INFO - 'PAGER': '/bin/cat', 15:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:35 INFO - 'PWD': '/builds/slave/test', 15:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:35 INFO - 'SHELL': '/bin/bash', 15:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:35 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:35 INFO - 'USER': 'cltbld', 15:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:35 INFO - 'XPC_FLAGS': '0x0', 15:10:35 INFO - 'XPC_SERVICE_NAME': '0', 15:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:35 INFO - Downloading/unpacking jsonschema 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:37 INFO - Downloading/unpacking functools32 (from jsonschema) 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10: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 15:10:38 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:38 INFO - warning: no files found matching '*.txt' 15:10:38 INFO - no previously-included directories found matching 'build' 15:10:38 INFO - no previously-included directories found matching 'dist' 15:10:38 INFO - no previously-included directories found matching '.git*' 15:10:38 INFO - Installing collected packages: jsonschema, functools32 15:10:38 INFO - Running setup.py install for functools32 15:10:38 INFO - warning: no files found matching '*.txt' 15:10:38 INFO - no previously-included directories found matching 'build' 15:10:38 INFO - no previously-included directories found matching 'dist' 15:10:38 INFO - no previously-included directories found matching '.git*' 15:10:38 INFO - Successfully installed jsonschema functools32 15:10:38 INFO - Cleaning up... 15:10:38 INFO - Return code: 0 15:10:38 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:10:38 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')]} 15:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:38 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')]} 15:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:10:38 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 0x1064d6a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064dd4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdff1cc1ba0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, '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.SDTicWI7ed/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.TWpD6EPRY3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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 15:10:38 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 15:10:38 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 15:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:10:38 INFO - 'HOME': '/Users/cltbld', 15:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:10:38 INFO - 'LOGNAME': 'cltbld', 15:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:38 INFO - 'MOZ_NO_REMOTE': '1', 15:10:38 INFO - 'NO_EM_RESTART': '1', 15:10:38 INFO - 'PAGER': '/bin/cat', 15:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:38 INFO - 'PWD': '/builds/slave/test', 15:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:10:38 INFO - 'SHELL': '/bin/bash', 15:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:10:38 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:10:38 INFO - 'USER': 'cltbld', 15:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:38 INFO - 'XPC_FLAGS': '0x0', 15:10:38 INFO - 'XPC_SERVICE_NAME': '0', 15:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:38 INFO - Downloading/unpacking flake8 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:38 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 15:10:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:10:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:10:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:41 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 15:10:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:10:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:42 INFO - no previously-included directories found matching 'docs/_build' 15:10:42 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:10:42 INFO - Running setup.py install for pep8 15:10:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:10:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:10:42 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:10:42 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:10:42 INFO - no previously-included directories found matching 'docs/_build' 15:10:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:10:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:10:42 INFO - Cleaning up... 15:10:43 INFO - Return code: 0 15:10:43 INFO - Running post-action listener: _resource_record_post_action 15:10:43 INFO - Running post-action listener: _start_resource_monitoring 15:10:43 INFO - Starting resource monitoring. 15:10:43 INFO - ##### 15:10:43 INFO - ##### Running install step. 15:10:43 INFO - ##### 15:10:43 INFO - Running pre-action listener: _resource_record_pre_action 15:10:43 INFO - Running main action method: install 15:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:43 INFO - Reading from file tmpfile_stdout 15:10:43 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:43 INFO - Reading from file tmpfile_stdout 15:10:43 INFO - Output received: 15:10:43 INFO - Usage: mozinstall [options] installer 15:10:43 INFO - Options: 15:10:43 INFO - -h, --help show this help message and exit 15:10:43 INFO - -d DEST, --destination=DEST 15:10:43 INFO - Directory to install application into. [default: 15:10:43 INFO - "/builds/slave/test"] 15:10:43 INFO - --app=APP Application being installed. [default: firefox] 15:10:43 INFO - mkdir: /builds/slave/test/build/application 15:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:11:15 INFO - Reading from file tmpfile_stdout 15:11:15 INFO - Output received: 15:11:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:11:15 INFO - Running post-action listener: _resource_record_post_action 15:11:15 INFO - ##### 15:11:15 INFO - ##### Running run-tests step. 15:11:15 INFO - ##### 15:11:15 INFO - Running pre-action listener: _resource_record_pre_action 15:11:15 INFO - Running main action method: run_tests 15:11:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:11:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:11:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:11:15 INFO - 2016-04-01 15:11:15.975 screenresolution[1647:7329] starting screenresolution argv=screenresolution get 15:11:15 INFO - 2016-04-01 15:11:15.978 screenresolution[1647:7329] Display 0: 1600x1200x32@60 15:11:15 INFO - 2016-04-01 15:11:15.984 screenresolution[1648:7331] starting screenresolution argv=screenresolution list 15:11:15 INFO - Available Modes on Display 0 15:11:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:11:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:11:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:11:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:11:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:11:16 INFO - Intel Iris: 15:11:16 INFO - Chipset Model: Intel Iris 15:11:16 INFO - Type: GPU 15:11:16 INFO - Bus: Built-In 15:11:16 INFO - VRAM (Dynamic, Max): 1536 MB 15:11:16 INFO - Vendor: Intel (0x8086) 15:11:16 INFO - Device ID: 0x0a2e 15:11:16 INFO - Revision ID: 0x0009 15:11:16 INFO - Displays: 15:11:16 INFO - Display: 15:11:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:11:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:11:16 INFO - Display Serial Number: 1600x1200 60 15:11:16 INFO - Main Display: Yes 15:11:16 INFO - Mirror: Off 15:11:16 INFO - Online: Yes 15:11:16 INFO - Rotation: Supported 15:11:16 INFO - Return code: 0 15:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:11:16 INFO - Python 2.7.3 15:11:16 INFO - Return code: 0 15:11:16 INFO - grabbing minidump binary from tooltool 15:11: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')]} 15:11: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 0x10637ad30>, '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 0x1061dedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106371b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:11: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 15:11: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 15:11:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:11:16 INFO - Return code: 0 15:11:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:11:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:11:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:11:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:11:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:11:17 INFO - Return code: 0 15:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--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 15:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0056 --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 15:11:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SDTicWI7ed/Render', 15:11:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:11:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:11:17 INFO - 'HOME': '/Users/cltbld', 15:11:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:11:17 INFO - 'LOGNAME': 'cltbld', 15:11:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:17 INFO - 'MOZ_NO_REMOTE': '1', 15:11:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:17 INFO - 'NO_EM_RESTART': '1', 15:11:17 INFO - 'PAGER': '/bin/cat', 15:11:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:17 INFO - 'PWD': '/builds/slave/test', 15:11:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:11:17 INFO - 'SHELL': '/bin/bash', 15:11:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TWpD6EPRY3/Listeners', 15:11:17 INFO - 'TMPDIR': '/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/', 15:11:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:11:17 INFO - 'USER': 'cltbld', 15:11:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:11:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:17 INFO - 'XPC_FLAGS': '0x0', 15:11:17 INFO - 'XPC_SERVICE_NAME': '0', 15:11:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:11:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0056', '--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 15:11:17 INFO - mozversion application_buildid: 20160401130352 15:11:17 INFO - mozversion application_changeset: faa65506b112a63784802378f8fa5610605c96b0 15:11:17 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:11:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:11:17 INFO - mozversion application_name: Firefox 15:11:17 INFO - mozversion application_remotingname: firefox-dev 15:11:17 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:17 INFO - mozversion application_vendor: Mozilla 15:11:17 INFO - mozversion application_version: 47.0a2 15:11:17 INFO - mozversion platform_buildid: 20160401130352 15:11:17 INFO - mozversion platform_changeset: faa65506b112a63784802378f8fa5610605c96b0 15:11:17 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:11:17 INFO - mozversion platform_version: 47.0a2 15:11:17 INFO - using testdate: 1459548677 15:11:17 INFO - actual date: 1459548677 15:11:17 INFO - starting webserver on 'localhost:49271' 15:11:17 INFO - SUITE-START | Running 2 tests 15:11:17 INFO - TEST-START | dromaeo_css 15:11:17 INFO - operating with platform_type : mac_ 15:11:17 INFO - Initialising browser for dromaeo_css test... 15:11:17 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp7IsDfA/profile http://localhost:49271/getInfo.html) 15:11:20 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 15:11:20 INFO - PROCESS | 1666 | colorDepth:24 15:11:20 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 15:11:20 INFO - PROCESS | 1666 | __metrics 15:11:20 INFO - PROCESS | 1666 | 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" 15:11:20 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:11:20 INFO - TEST-INFO | 1666: exit 0 15:11:20 INFO - Browser initialized. 15:11:20 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:20 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmp7IsDfA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:32 INFO - PROCESS | 1668 | RSS: Main: 210907136 15:11:32 INFO - PROCESS | 1668 | 15:12:23 INFO - PROCESS | 1668 | 1459548743671 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] 15:14:33 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 15:14:34 INFO - PROCESS | 1668 | RSS: Main: 322834432 15:14:34 INFO - PROCESS | 1668 | 15:17:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 15:17:38 INFO - PROCESS | 1668 | RSS: Main: 338391040 15:17:38 INFO - PROCESS | 1668 | 15:20:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 15:20:40 INFO - PROCESS | 1668 | RSS: Main: 351612928 15:20:40 INFO - PROCESS | 1668 | 15:23:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 15:23:43 INFO - PROCESS | 1668 | RSS: Main: 306475008 15:23:43 INFO - PROCESS | 1668 | 15:26:46 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 15:26:46 INFO - PROCESS | 1668 | RSS: Main: 307785728 15:26:46 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 15:29:49 INFO - PROCESS | 1668 | RSS: Main: 363683840 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | __start_tp_report 15:29:49 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 15:29:49 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 15:29:49 INFO - PROCESS | 1668 | |i|pagename|runs| 15:29:49 INFO - PROCESS | 1668 | |0;dojo.html;3456.291460250648;3508.2281897982434;3517.8065206413653;3548.2726041161563;3589.3539162950674;5347.358317001956;5557.777688892439;5728.856778580533;5744.885102297952;5763.1355296705515;5722.284714410699;5744.195812586241;5790.971045144779;5806.332271788746;5810.883782324351;5075.187969924813;5152.252923326116;5185;5227.47725227478;5249.86875328116;5222.686638801665;5228.320318358608;5229.633925625208;5231.319928409321;5248.658837175591;5210.973945130269;5241.8951620967555;5254.474552544753;5286.841394758163;5287.4976877196605;5285.365756109291;5296.285001524802;5322.680639161644;5347.25138480613;5347.465253474621;4164.729292595972;5191.299174611417;5206.947930520684;5224.425313215544;5230.816921407771;5657.830265092012;5694.4590263924865;5712.11462223356;5714.057180565202;5730.656160630376;6082.480917364355;6277.089821975834;6283.214598175228;6283.96858015707;6284.402981716729;5155.561777248939;6147.631142131487;6218.347073557256;6226.968865155691;6233.438990490878;5877.970610146965;5913.88190202421;5947.226860508106;5956.2852457704485;5959.642421454727;6146.569740118149;6228.626282423069;6276.058591211355;6287.59130656515;6304.464120549713;6159.692015399301;6179.69101544921;6196.969015154896;6207.286162091327;6227.377262273736;6204.534659900525;6226;6245.687715614201;6248.50011999039;6259.906101408483;6043.818685439356;6138.046095287564;6157.538184636171;6236;6256.6871656417;6234.0337247726675;6234.2830574483605;6241.188645476059;6263.6241825490615;6288.465480434123;4503.932441013388;4580.748058856728;4917.680350777188;4921.114199444134;4934.1611925972675;4168.353905144708;4349.412829268008;4409.603135717736;4441.533638967927;4464.6428285737065;5693.259876216065;5715.828525144252;5717.599768016199;5718.085106382959;5738.540916726652;6188.009918413032;6200.689965501707;6203.47270482005;6212.223472065992;6252.374762523802;5575.665460072409;5642;5684.062129748628;5702.45826646468;5713.4000929902595;5340.813071542478;5374.811881584125;5378;5379.892402152013;5396.91904621431;6299.0866324382705;6327.968360158262;6340.175777148941;6356.110144579762;6371;6139.062858969336;6149.508039356751;6193.225846769154;6239.688015599111;6243.937560624518;6347.460465860268;6351.110844481684;6358.872822543431;6361.586496877688;6377.8724425512155;6200.410960958701;6218.968905155445;6219.409156130341;6246.500279977682;6250.281217660027;6110.801781737137;6139.246828488627;6188.412100850412;6199.349068347939;6204.81385558434;5960;6163.38366163398;6164.229471316085;6169.81490555284;6170.784022559189;5904.439078287556;6108.4096180878705;6148.231471066117;6154.78458253959;6166.167567378526;5896.410358964069;6014.097885317063;6015.488683461955;6025;6047.485963693135;5870.530357571299;5887.20522729426;5903.675297858659;5927.2590926134235;5932.673702946379;5060.443351231288;5763.769449222152;5785.623934444247;5794.333651629948;5807.070868660994 15:29:49 INFO - PROCESS | 1668 | |1;ext.html;499.2610935814996;560.4115678537535;584.109233419036;602.0938487576199;612.292801813905;31416.528752068738;34906.77826276081;39230.2153956921;39698;40122;44048;45103.77448112763;45105.32342014872;45159.77420112903;45200.773996129974;9507.80984380312;9716.951415242915;9727.562259698296;9729.805403891918;9747.074027967332;7942.880856787153;9611.471369074698;9759.219262459023;9765;9784.217262618973;9717.174040206592;9826;9832.803343933118;9852.408855468659;9874.555644995957;9712.514374281292;9786.804263914717;9798.314118011742;9799.853002204973;9803;9525.761855953588;9644.807103857953;9668.70993870185;9677.70966870995;9682.903170968271;40700;40966.590334096574;41022;41052.589474105174;41109.38335924934;3132.9530057049164;3286.359159963808;3302.290007648367;3326.268220991378;3367.6463971282906;29068.8546557268;29175.978840740685;29292;29581.55627665587;29835;2789.2608458758446;2791.860406979643;2803.8177518461234;2874.9712502875122;2915.3149009982635;396415;401391;401674;402189;403489;67375;67892.98160527596;68092;68221.31778682249;68257.65871170712;69767.65116174489;75806.62096689481;76957;77037;77076.22923770691;18552.07239638013;18767.155478003522;18769.155388007573;18791;18793.718094228596;14124.293785310694;14203.218822964836;14212.71574568503;14222;14238;21928.671069933964;22295.44261393478;22302.776972230393;22327.441813954458;22338.329850104525;7490.4382171337365;7812.648430820626;9243.491607961627;9246.850710265388;9279.675211367705;925.3707478914403;1004;1027.0961553832578;1043.1029314789275;1080.1574771678104;29870.850645746632;29878.10365689033;29999.400012000075;30328.090157295315;30644.84677576598;1006.2151521812998;1083.3066837224183;1103.5254840418697;1181.3561608923158;1182.1606659272013;15282.465113720966;15415.460458883885;15449.845501545065;15599.220038998004;15699.764503532457;537283;542063;542325;542350;542939;49179.262311065366;59641;61331;61443.38556614466;61513;1396.8044473773477;1416.2226405860579;1506.3070987345725;1517.1655589425773;1543.0510236204652;26421.207363779118;27205.59191612167;29071.27321816887;29175.124746257647;29875;46973.355932542196;47321.76339118282;47383.28925066058;47421.762891185324;47496.7625161872;317320;326844;327037;327918;328419;29615.815367385065;33913;33994.490082649274;35010.124746880516;35018;53619.731901340245;53821.730891345294;53999.46000539944;54582.90834183373;56053.159202611176;35552.46671299984;39672.80163599164;39696.2060758789;40781.796091020544;41366.58633413627;36262.45606315855;39448.802755986035;39741.60258397495;40323.19353612853;40540.797296013334;40446.79776601098;41570.376444352754;41800;42416.787916060224;43389.69830905078;35470.29059418849;36065.639343607276;36580.26839463143;37203.06992325214;37391.25217495689;25156.24531264065;26755.464890702468;27720.564709646358;27977.86011070013;28103.016394426097 15:29:49 INFO - PROCESS | 1668 | |2;jquery.html;366.7561071887195;373.3037884345696;373.90278527582836;378.9962100378997;382.0220236195342;19298.71051934222;19845.801541984576;20546;21188.046537905793;21435.82102984335;19645.901770491164;19822.60354792907;20440.693389599168;20444.488887777814;20666.586668266627;5910.054391297383;6071.878562428748;6113.7860174893885;6115.510759139258;6135.110408990694;5817.476427121558;5964.403559644044;6010.669413182273;6052.878942421149;6055;5925.585209035369;5947.762089516415;5961.374055724152;5962.433568810956;5963.135345374918;5746.1955326254565;5829.679367634779;5877.324107727623;5886.941130588682;5962.701864906738;5074.5432911037815;5084.669496482717;5088.338515992934;5095.388553373582;5106.923396149061;25251.242462726146;25464.981400744135;25837.741622583908;25903.35241618956;25931.351716207246;2197.7252843394576;2430.3073624017247;2503.4492411669585;2810.9599448204294;2836.914892553206;14812.333444995002;14987.550373488704;15059.397624095023;15069;15217.163056031914;1598.6882557901097;1724.5947202407424;1734.4363081998401;1781.5100847266976;1803.998780676724;101617.4919125407;103817.44273835898;103838.88483345511;104100.47949760202;104424;8667.4366166199;11159.442027898573;11176.441177941071;11228.27016243958;11490.195686301879;13560.660983475493;13592;13592.048556601141;13627.977901657217;13658.863411365957;7247.420206383476;8588.699395521127;8652.610632521551;8753.912460875437;8766.517841518651;8707.912920870836;8711.47731136134;8711.782205444788;8830;8834.86747698785;5331.733413329318;6557.967210163919;6571.408573228432;6572.572782769104;6572.967135164389;1599.6800639872072;1836.1186630417208;1839.264294282298;1870.2332043861952;1876.626068023951;760.5322726523259;930.4510338899946;933.1601558597316;1005.9094681478703;1047.4343854318736;18245;20343.28798492046;21277.68083478749;21587.56824863494;21811.890940545512;970.126885802769;972.6984634763105;1026.6868605075524;1057.413135709673;1063.1919740996743;11423.143264255048;11734.647960561197;11760.235584686969;11813.291202527877;12043.638690839289;502106.4894675503;534579.327103362;539510;543421;639113;126487;131974;132363.01455478175;135401;139753;1019.1744686803713;1061.193492945367;1069.2248120112856;1073.0074680920118;1074.9462526873624;18188.272469101088;18318.72521912199;18442.631147377244;18759.906200469457;19019.90490047541;33803.83098084494;42675.7866210667;45350.77324613356;51392;53242.208201262074;55453.44546554483;74727.2527274742;76510.23489765031;76621;77151;7724.536527808349;7857.371410287277;7914;7946.284834364704;7997.800054998672;9146.314026448175;12277;12834.358282085672;13199.604011879659;13264.336783160996;10910.509027093642;11195.664130076111;11400.543978240778;11599.942000290283;11620.883791162318;10958.45207739594;11065.723356916142;11221.102311814871;11400.48697808584;11408.600698975495;11360.1479889007;11482.25365351283;11647.708807279547;11704.005159561533;11770.999465045224;7792.259735325361;7968.083670377749;7999.440039197433;8088.919110808816;8181.427300088937;9875.358101723652;11328.263662861887;11379.317240965569;11553.884461155281;11699.473523691284 15:29:49 INFO - PROCESS | 1668 | |3;mootools.html;1493.0071502450871;1631.1925596829567;1672.1221358786636;1980.8217260446556;2060.752709674838;8288.171182881717;8961.507117108556;9133.68032118876;9137.406068605536;9141.862872056916;8775.517346545937;9040.457572545653;9061.229795467376;9069.229115525171;9070.727878163665;2259.898304576298;2527.772500474957;2528.0393450488787;2559.065940931556;2578.9097381591646;2599.922002339933;2600.219934019796;2611.3602167468903;2611.595202743578;2612.7387261273816;2465.2480993297036;2573.987130064347;2578.2909699832603;2580.1743442098536;2582.7417258274118;2152.9354119376367;2555.501677172952;2578.084779903126;2578.2265320403803;2584.3280747005724;2524.507720994407;2565.615157726337;2566.525192839331;2568.845869247851;2584.3539115221197;9124.680636177769;9208.447493150432;9225.67710130149;9236.5843537041;9239.769005774842;5563.721813909288;5682.602217844753;5725.341585717654;5730.025895597717;5730.598858079936;3666.6883314918264;3720.7023438124884;3815.313243616148;3822.789746563938;3827.5215598050245;1054.3568423261804;1055.6991257491577;1055.841623756435;1073.0878753059837;1115.1970581181536;12388.876111238953;12413.751724965541;12436;12444.87996080348;12471.438785254686;5007.574356179693;5013.39839219296;5097.745112744422;5130.87172820675;5133.6919784813035;10487.685369438928;10514.631987880388;10518.789624207473;10521.3687178768;10528.842067368996;5700.686462244534;5709.74306156224;5714.228579141846;5719.942800572025;5724.112762521816;4433.445819272591;4575.22221222393;4979.30289759434;5030.673006254582;5083.796648134034;4065.8180935346095;4113.958860411358;4134.4831896013;4167.041580436517;4170.291050521419;1323.7213040738673;1331.6587923369884;1335.5309159924007;1336.9571734047458;1338.8887223604386;1383.2253937794867;1412.5409241996392;1435.519101101122;1441.7332793433247;1443.8556144385686;8478.576071196416;8627.827443451222;8630.741077767678;8643.35174861888;8688;1145.7765735681462;1207.7161866961258;1261.4197469164103;1266.4744131185455;1277.482619539088;6421.101045853584;6501.544891857525;6539.47684185264;6541.934580654228;6546.410823025951;10840.295380800222;11158.888411115948;11260.324380537195;11279.774404511863;11306.434678266054;10838.512266948006;10895.346279223271;11075.833862492069;11119.16606254518;11157.66527004191;8592.882925219807;8644.610992505352;8732.60703268367;8752.168543988439;8767.473951562926;7011.964940175267;8106.837863242584;8167.591620418836;8171.591420429074;8264.876026859481;8398.244158025807;8974.878140232471;9809;9973.451460169761;10083.647072352433;9781.902180978099;10017.998200179924;10041.347312424668;10193.694189174337;10217.948910255402;7247.855042899218;7265.527740697049;7269.273072692688;7334.853302934018;7350.301721336465;8314.127016663164;8338;8379.329653627818;8391.454555453876;8398.244158025807;7480.102387713509;7718.92281077182;7755.767326979974;7812.609369531387;7829.921700782919;7500.399968002437;7543.321101100927;7576.4317676173405;7691.2308769124875;7701.653425595974;8017.518948863087;8057.838843222986;8084.7574572762915;8088.474249173785;8099.068607110258;6974.825629359104;7225.6387180641805;7243.891341629775;7255.09311336083;7276.05411296528;7265.564066156047;7286.526375785769;7295.051643286339;7332.743353982585;7345.853082938204 15:29:49 INFO - PROCESS | 1668 | |4;prototype.html;327.53980657176663;329.4432409228404;333.39156040226595;334.9765516413851;338.5311343788853;6553.606783592988;6554.868902621956;6588.209414870216;6609.933900660998;6627.072209890607;6534.248561415438;6544.738210471587;6556.934430655692;6568.901466477994;6569.605823650584;4354.956450435487;4379.146066517031;4675.859724208262;4802.375691160144;4880.829170979016;4808.206645903421;4818.229083346665;4823.493533179018;4842.515748425165;4859.538343857328;4822.348982887301;4839.346688197101;4841.298011788289;4849.636277279201;4852.49048849871;4602.424696912886;4692;4724.291356296549;4743.762811859393;4873.195922672755;4176.958230417687;4180.707350485467;4189;4193.748375097504;4222.387753775716;6264.937350626481;6275.968620156916;6296.087067375205;6302.275238347557;6314.400131987454;5747.339056008529;5783.450572195635;5783.5084017858535;5789.536837053026;5792.710364481801;5703.828885133453;6681.53229273951;6942.514024018321;6964.965175174142;6981;4644.489106198315;4693.20215563355;4697.6241900647865;4711.764411779432;4734.4081989751285;5841.3282472515775;7344.4491663124945;7358.77923662291;7361.852762944711;7394.926050739477;4762.928556071662;4790.616750659939;4796.928046079312;4812;4813.855584332476;4857;4860.68405553645;4864.318995340655;4865.537773911473;4875.536824001714;5757.136429535603;5765.135229715576;5781.19063331134;5791.942080579141;5801.042827933428;5697.914531282034;6715.529912906148;7001.614911179832;7021.754238601625;7041.978913057578;1664.6753882992941;1672.7240005399217;1679.4709666455028;1682.9915850420668;1688.0799964019639;933.5145724223365;1095.9671209863716;1111.3276467736903;1111.6164923101517;1113.5211858900589;6254.499640028786;6403.519736019724;6406.103145559626;6412.198475190601;6439.9356006440275;7145.428365730729;7169.175544812413;7329.340359367576;7341.229170936975;7359.264073592598;6502.869942601122;6506.446952009038;6515.4787616990525;6523.804285871432;6528.412442880163;3835.386338185877;3875.7210120660116;3882.514685664292;3882.825272862728;3882.893375388001;7400.962995184989;7679.078510578766;7680.385569154454;7696.076470823537;7697.923020769833;7555.206703296185;7556.433267504959;7571.659275332623;7574.901639262276;7602.657880395395;7627.656755446018;7632.69469221225;7634.923650763421;7636.785332253584;7648.043994500687;6266.279377871603;7010.193827709879;7051.717931282691;7288.526245794006;7329.377002954809;7144.607046612487;7219.061522002106;7219.783406497813;7227.096612923385;7231.349178573953;6217.347178546188;7508.737194198176;7638.923610763822;7639.159692433716;7646.350060244941;4829;4836.12949669063;4839.612830973443;4839.782209800638;4848.636352273664;7020.684069217;7263.201047884623;7271.4546409020595;7272.418206543358;7289.161746399232;7039.542429742255;7096.290370962863;7132.429405647639;7134.643267836691;7170.462215333767;7038.824029399101;7062.71749130029;7082.256363081802;7090.255523169993;7102.5028248022145;6873.037774711444;6875.243723190545;6888.655567221719;6903.792886213421;6915.896261556181;6803.523753337417;7023.157221133497;7038.8944165838575;7047.788566343018;7054.294570542905;5706.830099829442;6553.115329430466;6790.151231096113;6919.377256046779;6956.130483689539 15:29:49 INFO - PROCESS | 1668 | |5;yui.html;708.4934271995523;764.3503022430931;770.6223950264372;771.4060173666273;814.5153633588014;15107.546773596781;15167.469138580153;15290.46483373082;15318.770218446733;15343.002704824192;13859;14035.789463158035;14044.438222471088;14044.438222471088;14054.718905621907;779.6608475313228;784.4430454377399;935.0322416299115;949.5252373813094;972.4700038479045;970.5486948568914;973.2360097323602;973.4256788494787;973.7078876337106;974.2400927276735;1029.4183786160795;1030.0780801182937;1030.1810061001484;1030.340582027503;1031.4791030529573;828.8963879515061;907.791208022152;1015.6800607808591;1015.8222311095602;1020.1532727835915;752.6801109528483;753.9170691223961;755.0599503617976;755.2749360613817;755.5202446446491;14926;15026.323815428223;15029.849701503064;15033.548993530212;15047.623809404742;12510.249385036836;12679.93660031694;12767;12947.935260323638;13032.478700851954;9931.90068099317;9940.15508681763;9983.950080249553;10318.432486213254;10694.572217111307;3492.3189977954307;3539.539859818233;3555.2178520725397;3586.910327241814;3787;74998;75697.62151189263;76955.84566231455;76964.46071078604;77401;9700.126988571063;9724.319297649097;9750.853737193947;9777.511124443748;9841.704748857546;22269.331920042423;23103;23135.53728925412;23152.305430837103;23169;7510;7556.58438785872;7566.508176968479;7717.614119294013;7939.285464308125;4074.4295798587627;4095.7133000689664;4116.794160291974;4170.436991006175;4394.978025109854;3731.8880433587037;3775.6035616259896;3784.4512545680723;3787.6780473660046;3793.2982398256413;607.1894021481284;653.1900443450088;667.7162206062404;671.4225765841372;675.0818886314609;518.2588897876074;524.0933185588876;565.2877374508149;567.4042255631653;607.9392060793886;7369.8894516582295;8195.385346099067;8277.791327980765;8333.250007499355;8374.330053595697;582.0948425198857;590.8493334199752;597.4384078965759;603.2278683285401;620.8447888027993;3785.4511095890944;3908.1988192420486;3908.6286802753693;3921.117748506563;3973.543042550086;86668;88722.11277887267;90451;91018;100714.4964275174;74737.87893181607;79090;80018;80525;82142.17857821465;72225.2777472229;72846;73358.99999999894;73658;74306;7240.456965727697;8344.249017588203;8510.82978340442;8703.608337624948;8814.691485797966;51638;51764;51805.7409712949;52014;52080.73959630178;68394.3160568388;73621;73872;74459.62770186114;74699.1325216874;10902.454877256265;11057.668269951915;11188.440577970907;11434.771304573696;11523.711907202387;9410.576524056298;11812.76374472523;11886.227395219283;12087.697807554881;12171.513139474322;9399.530023498934;10826.40454774995;11699.88300116988;11752;11815.350155741517;11720.413979301171;11882.584109556125;11884.405779711153;11916.821247681464;11980.520779168735;11055.557777688802;11341.546338146381;11396.936189703407;11462.025727813229;12139.696507587381;9430.387024843363;9561.61753529851;9731.854022189815;9854;10059;9399.10708482693;9797.363171393836;9805.509724513888;9826.508674566387;9905.752356190864 15:29:49 INFO - PROCESS | 1668 | __end_tp_report 15:29:49 INFO - PROCESS | 1668 | __start_cc_report 15:29:49 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1065 15:29:49 INFO - PROCESS | 1668 | __end_cc_report 15:29:49 INFO - PROCESS | 1668 | __startTimestamp1459549789732__endTimestamp 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | ------- Summary: start ------- 15:29:49 INFO - PROCESS | 1668 | Number of tests: 6 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5728.67 Median:5913.88 stddev:640.57 (10.8%) stddev-sans-first:617.23 15:29:49 INFO - PROCESS | 1668 | Values: 3456.3 3508.2 3517.8 3548.3 3589.4 5347.4 5557.8 5728.9 5744.9 5763.1 5722.3 5744.2 5791.0 5806.3 5810.9 5075.2 5152.3 5185.0 5227.5 5249.9 5222.7 5228.3 5229.6 5231.3 5248.7 5211.0 5241.9 5254.5 5286.8 5287.5 5285.4 5296.3 5322.7 5347.3 5347.5 4164.7 5191.3 5206.9 5224.4 5230.8 5657.8 5694.5 5712.1 5714.1 5730.7 6082.5 6277.1 6283.2 6284.0 6284.4 5155.6 6147.6 6218.3 6227.0 6233.4 5878.0 5913.9 5947.2 5956.3 5959.6 6146.6 6228.6 6276.1 6287.6 6304.5 6159.7 6179.7 6197.0 6207.3 6227.4 6204.5 6226.0 6245.7 6248.5 6259.9 6043.8 6138.0 6157.5 6236.0 6256.7 6234.0 6234.3 6241.2 6263.6 6288.5 4503.9 4580.7 4917.7 4921.1 4934.2 4168.4 4349.4 4409.6 4441.5 4464.6 5693.3 5715.8 5717.6 5718.1 5738.5 6188.0 6200.7 6203.5 6212.2 6252.4 5575.7 5642.0 5684.1 5702.5 5713.4 5340.8 5374.8 5378.0 5379.9 5396.9 6299.1 6328.0 6340.2 6356.1 6371.0 6139.1 6149.5 6193.2 6239.7 6243.9 6347.5 6351.1 6358.9 6361.6 6377.9 6200.4 6219.0 6219.4 6246.5 6250.3 6110.8 6139.2 6188.4 6199.3 6204.8 5960.0 6163.4 6164.2 6169.8 6170.8 5904.4 6108.4 6148.2 6154.8 6166.2 5896.4 6014.1 6015.5 6025.0 6047.5 5870.5 5887.2 5903.7 5927.3 5932.7 5060.4 5763.8 5785.6 5794.3 5807.1 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:59391.76 Median:220756.50 stddev:114514.46 (51.9%) stddev-sans-first:114750.33 15:29:49 INFO - PROCESS | 1668 | Values: 499.3 560.4 584.1 602.1 612.3 31416.5 34906.8 39230.2 39698.0 40122.0 44048.0 45103.8 45105.3 45159.8 45200.8 9507.8 9717.0 9727.6 9729.8 9747.1 7942.9 9611.5 9759.2 9765.0 9784.2 9717.2 9826.0 9832.8 9852.4 9874.6 9712.5 9786.8 9798.3 9799.9 9803.0 9525.8 9644.8 9668.7 9677.7 9682.9 40700.0 40966.6 41022.0 41052.6 41109.4 3133.0 3286.4 3302.3 3326.3 3367.6 29068.9 29176.0 29292.0 29581.6 29835.0 2789.3 2791.9 2803.8 2875.0 2915.3 396415.0 401391.0 401674.0 402189.0 403489.0 67375.0 67893.0 68092.0 68221.3 68257.7 69767.7 75806.6 76957.0 77037.0 77076.2 18552.1 18767.2 18769.2 18791.0 18793.7 14124.3 14203.2 14212.7 14222.0 14238.0 21928.7 22295.4 22302.8 22327.4 22338.3 7490.4 7812.6 9243.5 9246.9 9279.7 925.4 1004.0 1027.1 1043.1 1080.2 29870.9 29878.1 29999.4 30328.1 30644.8 1006.2 1083.3 1103.5 1181.4 1182.2 15282.5 15415.5 15449.8 15599.2 15699.8 537283.0 542063.0 542325.0 542350.0 542939.0 49179.3 59641.0 61331.0 61443.4 61513.0 1396.8 1416.2 1506.3 1517.2 1543.1 26421.2 27205.6 29071.3 29175.1 29875.0 46973.4 47321.8 47383.3 47421.8 47496.8 317320.0 326844.0 327037.0 327918.0 328419.0 29615.8 33913.0 33994.5 35010.1 35018.0 53619.7 53821.7 53999.5 54582.9 56053.2 35552.5 39672.8 39696.2 40781.8 41366.6 36262.5 39448.8 39741.6 40323.2 40540.8 40446.8 41570.4 41800.0 42416.8 43389.7 35470.3 36065.6 36580.3 37203.1 37391.3 25156.2 26755.5 27720.6 27977.9 28103.0 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:33273.09 Median:21699.73 stddev:92547.75 (426.5%) stddev-sans-first:92774.39 15:29:49 INFO - PROCESS | 1668 | Values: 366.8 373.3 373.9 379.0 382.0 19298.7 19845.8 20546.0 21188.0 21435.8 19645.9 19822.6 20440.7 20444.5 20666.6 5910.1 6071.9 6113.8 6115.5 6135.1 5817.5 5964.4 6010.7 6052.9 6055.0 5925.6 5947.8 5961.4 5962.4 5963.1 5746.2 5829.7 5877.3 5886.9 5962.7 5074.5 5084.7 5088.3 5095.4 5106.9 25251.2 25465.0 25837.7 25903.4 25931.4 2197.7 2430.3 2503.4 2811.0 2836.9 14812.3 14987.6 15059.4 15069.0 15217.2 1598.7 1724.6 1734.4 1781.5 1804.0 101617.5 103817.4 103838.9 104100.5 104424.0 8667.4 11159.4 11176.4 11228.3 11490.2 13560.7 13592.0 13592.0 13628.0 13658.9 7247.4 8588.7 8652.6 8753.9 8766.5 8707.9 8711.5 8711.8 8830.0 8834.9 5331.7 6558.0 6571.4 6572.6 6573.0 1599.7 1836.1 1839.3 1870.2 1876.6 760.5 930.5 933.2 1005.9 1047.4 18245.0 20343.3 21277.7 21587.6 21811.9 970.1 972.7 1026.7 1057.4 1063.2 11423.1 11734.6 11760.2 11813.3 12043.6 502106.5 534579.3 539510.0 543421.0 639113.0 126487.0 131974.0 132363.0 135401.0 139753.0 1019.2 1061.2 1069.2 1073.0 1074.9 18188.3 18318.7 18442.6 18759.9 19019.9 33803.8 42675.8 45350.8 51392.0 53242.2 55453.4 74727.3 76510.2 76621.0 77151.0 7724.5 7857.4 7914.0 7946.3 7997.8 9146.3 12277.0 12834.4 13199.6 13264.3 10910.5 11195.7 11400.5 11599.9 11620.9 10958.5 11065.7 11221.1 11400.5 11408.6 11360.1 11482.3 11647.7 11704.0 11771.0 7792.3 7968.1 7999.4 8088.9 8181.4 9875.4 11328.3 11379.3 11553.9 11699.5 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6272.78 Median:5057.23 stddev:3279.20 (64.8%) stddev-sans-first:3268.72 15:29:49 INFO - PROCESS | 1668 | Values: 1493.0 1631.2 1672.1 1980.8 2060.8 8288.2 8961.5 9133.7 9137.4 9141.9 8775.5 9040.5 9061.2 9069.2 9070.7 2259.9 2527.8 2528.0 2559.1 2578.9 2599.9 2600.2 2611.4 2611.6 2612.7 2465.2 2574.0 2578.3 2580.2 2582.7 2152.9 2555.5 2578.1 2578.2 2584.3 2524.5 2565.6 2566.5 2568.8 2584.4 9124.7 9208.4 9225.7 9236.6 9239.8 5563.7 5682.6 5725.3 5730.0 5730.6 3666.7 3720.7 3815.3 3822.8 3827.5 1054.4 1055.7 1055.8 1073.1 1115.2 12388.9 12413.8 12436.0 12444.9 12471.4 5007.6 5013.4 5097.7 5130.9 5133.7 10487.7 10514.6 10518.8 10521.4 10528.8 5700.7 5709.7 5714.2 5719.9 5724.1 4433.4 4575.2 4979.3 5030.7 5083.8 4065.8 4114.0 4134.5 4167.0 4170.3 1323.7 1331.7 1335.5 1337.0 1338.9 1383.2 1412.5 1435.5 1441.7 1443.9 8478.6 8627.8 8630.7 8643.4 8688.0 1145.8 1207.7 1261.4 1266.5 1277.5 6421.1 6501.5 6539.5 6541.9 6546.4 10840.3 11158.9 11260.3 11279.8 11306.4 10838.5 10895.3 11075.8 11119.2 11157.7 8592.9 8644.6 8732.6 8752.2 8767.5 7012.0 8106.8 8167.6 8171.6 8264.9 8398.2 8974.9 9809.0 9973.5 10083.6 9781.9 10018.0 10041.3 10193.7 10217.9 7247.9 7265.5 7269.3 7334.9 7350.3 8314.1 8338.0 8379.3 8391.5 8398.2 7480.1 7718.9 7755.8 7812.6 7829.9 7500.4 7543.3 7576.4 7691.2 7701.7 8017.5 8057.8 8084.8 8088.5 8099.1 6974.8 7225.6 7243.9 7255.1 7276.1 7265.6 7286.5 7295.1 7332.7 7345.9 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5754.98 Median:6504.66 stddev:1810.30 (27.8%) stddev-sans-first:1768.95 15:29:49 INFO - PROCESS | 1668 | Values: 327.5 329.4 333.4 335.0 338.5 6553.6 6554.9 6588.2 6609.9 6627.1 6534.2 6544.7 6556.9 6568.9 6569.6 4355.0 4379.1 4675.9 4802.4 4880.8 4808.2 4818.2 4823.5 4842.5 4859.5 4822.3 4839.3 4841.3 4849.6 4852.5 4602.4 4692.0 4724.3 4743.8 4873.2 4177.0 4180.7 4189.0 4193.7 4222.4 6264.9 6276.0 6296.1 6302.3 6314.4 5747.3 5783.5 5783.5 5789.5 5792.7 5703.8 6681.5 6942.5 6965.0 6981.0 4644.5 4693.2 4697.6 4711.8 4734.4 5841.3 7344.4 7358.8 7361.9 7394.9 4762.9 4790.6 4796.9 4812.0 4813.9 4857.0 4860.7 4864.3 4865.5 4875.5 5757.1 5765.1 5781.2 5791.9 5801.0 5697.9 6715.5 7001.6 7021.8 7042.0 1664.7 1672.7 1679.5 1683.0 1688.1 933.5 1096.0 1111.3 1111.6 1113.5 6254.5 6403.5 6406.1 6412.2 6439.9 7145.4 7169.2 7329.3 7341.2 7359.3 6502.9 6506.4 6515.5 6523.8 6528.4 3835.4 3875.7 3882.5 3882.8 3882.9 7401.0 7679.1 7680.4 7696.1 7697.9 7555.2 7556.4 7571.7 7574.9 7602.7 7627.7 7632.7 7634.9 7636.8 7648.0 6266.3 7010.2 7051.7 7288.5 7329.4 7144.6 7219.1 7219.8 7227.1 7231.3 6217.3 7508.7 7638.9 7639.2 7646.4 4829.0 4836.1 4839.6 4839.8 4848.6 7020.7 7263.2 7271.5 7272.4 7289.2 7039.5 7096.3 7132.4 7134.6 7170.5 7038.8 7062.7 7082.3 7090.3 7102.5 6873.0 6875.2 6888.7 6903.8 6915.9 6803.5 7023.2 7038.9 7047.8 7054.3 5706.8 6553.1 6790.2 6919.4 6956.1 15:29:49 INFO - PROCESS | 1668 | 15:29:49 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18573.58 Median:594.14 stddev:25976.76 (4372.1%) stddev-sans-first:26014.99 15:29:49 INFO - PROCESS | 1668 | Values: 708.5 764.4 770.6 771.4 814.5 15107.5 15167.5 15290.5 15318.8 15343.0 13859.0 14035.8 14044.4 14044.4 14054.7 779.7 784.4 935.0 949.5 972.5 970.5 973.2 973.4 973.7 974.2 1029.4 1030.1 1030.2 1030.3 1031.5 828.9 907.8 1015.7 1015.8 1020.2 752.7 753.9 755.1 755.3 755.5 14926.0 15026.3 15029.8 15033.5 15047.6 12510.2 12679.9 12767.0 12947.9 13032.5 9931.9 9940.2 9984.0 10318.4 10694.6 3492.3 3539.5 3555.2 3586.9 3787.0 74998.0 75697.6 76955.8 76964.5 77401.0 9700.1 9724.3 9750.9 9777.5 9841.7 22269.3 23103.0 23135.5 23152.3 23169.0 7510.0 7556.6 7566.5 7717.6 7939.3 4074.4 4095.7 4116.8 4170.4 4395.0 3731.9 3775.6 3784.5 3787.7 3793.3 607.2 653.2 667.7 671.4 675.1 518.3 524.1 565.3 567.4 607.9 7369.9 8195.4 8277.8 8333.3 8374.3 582.1 590.8 597.4 603.2 620.8 3785.5 3908.2 3908.6 3921.1 3973.5 86668.0 88722.1 90451.0 91018.0 100714.5 74737.9 79090.0 80018.0 80525.0 82142.2 72225.3 72846.0 73359.0 73658.0 74306.0 7240.5 8344.2 8510.8 8703.6 8814.7 51638.0 51764.0 51805.7 52014.0 52080.7 68394.3 73621.0 73872.0 74459.6 74699.1 10902.5 11057.7 11188.4 11434.8 11523.7 9410.6 11812.8 11886.2 12087.7 12171.5 9399.5 10826.4 11699.9 11752.0 11815.4 11720.4 11882.6 11884.4 11916.8 11980.5 11055.6 11341.5 11396.9 11462.0 12139.7 9430.4 9561.6 9731.9 9854.0 10059.0 9399.1 9797.4 9805.5 9826.5 9905.8 15:29:49 INFO - PROCESS | 1668 | -------- Summary: end -------- 15:29:49 INFO - PROCESS | 1668 | 15:29:50 INFO - TEST-INFO | 1668: exit 0 15:29:50 INFO - TEST-OK | dromaeo_css | took 1112575ms 15:29:50 INFO - TEST-START | kraken 15:29:50 INFO - operating with platform_type : mac_ 15:29:50 INFO - Initialising browser for kraken test... 15:29:50 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpsiTHBe/profile http://localhost:49271/getInfo.html) 15:29:52 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 15:29:52 INFO - PROCESS | 1678 | colorDepth:24 15:29:52 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 15:29:52 INFO - PROCESS | 1678 | __metrics 15:29:52 INFO - PROCESS | 1678 | 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" 15:29:52 INFO - PROCESS | 1678 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:29:52 INFO - TEST-INFO | 1678: exit 0 15:29:52 INFO - Browser initialized. 15:29:52 INFO - Running cycle 1/1 for kraken test... 15:29:52 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/T/tmpsiTHBe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:30:05 INFO - PROCESS | 1680 | RSS: Main: 209129472 15:30:05 INFO - PROCESS | 1680 | 15:30:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 15:30:08 INFO - PROCESS | 1680 | RSS: Main: 265392128 15:30:08 INFO - PROCESS | 1680 | 15:30:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 15:30:11 INFO - PROCESS | 1680 | RSS: Main: 275628032 15:30:11 INFO - PROCESS | 1680 | 15:30:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 15:30:15 INFO - PROCESS | 1680 | RSS: Main: 263589888 15:30:15 INFO - PROCESS | 1680 | 15:30:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 15:30:17 INFO - PROCESS | 1680 | RSS: Main: 266145792 15:30:17 INFO - PROCESS | 1680 | 15:30:19 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:30:20 INFO - PROCESS | 1680 | RSS: Main: 266297344 15:30:20 INFO - PROCESS | 1680 | 15:30:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:23 INFO - PROCESS | 1680 | RSS: Main: 267726848 15:30:23 INFO - PROCESS | 1680 | 15:30:26 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:26 INFO - PROCESS | 1680 | RSS: Main: 267833344 15:30:26 INFO - PROCESS | 1680 | 15:30:29 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 15:30:30 INFO - PROCESS | 1680 | RSS: Main: 266231808 15:30:30 INFO - PROCESS | 1680 | 15:30:32 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:32 INFO - PROCESS | 1680 | RSS: Main: 301203456 15:30:32 INFO - PROCESS | 1680 | 15:30:34 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:35 INFO - PROCESS | 1680 | RSS: Main: 302190592 15:30:35 INFO - PROCESS | 1680 | 15:30:37 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:37 INFO - PROCESS | 1680 | RSS: Main: 307953664 15:30:37 INFO - PROCESS | 1680 | 15:30:40 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:40 INFO - PROCESS | 1680 | RSS: Main: 310845440 15:30:40 INFO - PROCESS | 1680 | 15:30:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:43 INFO - PROCESS | 1680 | RSS: Main: 310947840 15:30:43 INFO - PROCESS | 1680 | 15:30:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 15:30:46 INFO - PROCESS | 1680 | RSS: Main: 369856512 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | __start_tp_report 15:30:46 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 15:30:46 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 15:30:46 INFO - PROCESS | 1680 | |i|pagename|runs| 15:30:46 INFO - PROCESS | 1680 | |0;ai-astar;113;109;111;111;111;112;119;111;111;113 15:30:46 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;121;140;154;119;137;118;152;142;116 15:30:46 INFO - PROCESS | 1680 | |2;audio-dft;185;185;186;182;185;184;183;184;184;182 15:30:46 INFO - PROCESS | 1680 | |3;audio-fft;80;72;74;115;56;58;57;58;115;55 15:30:46 INFO - PROCESS | 1680 | |4;audio-oscillator;91;92;131;80;78;88;114;76;79;116 15:30:46 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;90;87;91;87;89;87;92;87;89;86 15:30:46 INFO - PROCESS | 1680 | |6;imaging-darkroom;96;95;95;95;96;96;96;96;95;96 15:30:46 INFO - PROCESS | 1680 | |7;imaging-desaturate;89;88;87;90;93;141;134;90;89;90 15:30:46 INFO - PROCESS | 1680 | |8;json-parse-financial;57;58;59;58;54;59;83;85;54;54 15:30:46 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;64;64;75;73;69;67;65;67;66;63 15:30:46 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;81;81;82;80;79;80;81;80;82;84 15:30:46 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;121;133;133;118;117;123;115;116;115;117 15:30:46 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;130;122;133;130;125;107;141;117;163;165 15:30:46 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;70;91;91;89;78;64;65;66;65 15:30:46 INFO - PROCESS | 1680 | __end_tp_report 15:30:46 INFO - PROCESS | 1680 | __start_cc_report 15:30:46 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1230 15:30:46 INFO - PROCESS | 1680 | __end_cc_report 15:30:46 INFO - PROCESS | 1680 | __startTimestamp1459549846022__endTimestamp 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | ------- Summary: start ------- 15:30:46 INFO - PROCESS | 1680 | Number of tests: 14 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:112.10 Median:111.50 stddev:2.69 (2.4%) stddev-sans-first:2.83 15:30:46 INFO - PROCESS | 1680 | Values: 113.0 109.0 111.0 111.0 111.0 112.0 119.0 111.0 111.0 113.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:141.00 stddev:15.74 (11.2%) stddev-sans-first:15.01 15:30:46 INFO - PROCESS | 1680 | Values: 155.0 121.0 140.0 154.0 119.0 137.0 118.0 152.0 142.0 116.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.33 (0.7%) stddev-sans-first:1.36 15:30:46 INFO - PROCESS | 1680 | Values: 185.0 185.0 186.0 182.0 185.0 184.0 183.0 184.0 184.0 182.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:74.00 Median:58.00 stddev:23.30 (40.2%) stddev-sans-first:24.62 15:30:46 INFO - PROCESS | 1680 | Values: 80.0 72.0 74.0 115.0 56.0 58.0 57.0 58.0 115.0 55.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.50 stddev:19.15 (24.1%) stddev-sans-first:20.27 15:30:46 INFO - PROCESS | 1680 | Values: 91.0 92.0 131.0 80.0 78.0 88.0 114.0 76.0 79.0 116.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:89.00 stddev:2.01 (2.3%) stddev-sans-first:2.06 15:30:46 INFO - PROCESS | 1680 | Values: 90.0 87.0 91.0 87.0 89.0 87.0 92.0 87.0 89.0 86.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:30:46 INFO - PROCESS | 1680 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:99.10 Median:89.50 stddev:20.37 (22.8%) stddev-sans-first:21.27 15:30:46 INFO - PROCESS | 1680 | Values: 89.0 88.0 87.0 90.0 93.0 141.0 134.0 90.0 89.0 90.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:58.50 stddev:11.72 (20.0%) stddev-sans-first:12.29 15:30:46 INFO - PROCESS | 1680 | Values: 57.0 58.0 59.0 58.0 54.0 59.0 83.0 85.0 54.0 54.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:3.97 (5.9%) stddev-sans-first:4.03 15:30:46 INFO - PROCESS | 1680 | Values: 64.0 64.0 75.0 73.0 69.0 67.0 65.0 67.0 66.0 63.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.41 (1.7%) stddev-sans-first:1.50 15:30:46 INFO - PROCESS | 1680 | Values: 81.0 81.0 82.0 80.0 79.0 80.0 81.0 80.0 82.0 84.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:119.50 stddev:6.91 (5.8%) stddev-sans-first:7.33 15:30:46 INFO - PROCESS | 1680 | Values: 121.0 133.0 133.0 118.0 117.0 123.0 115.0 116.0 115.0 117.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.30 Median:131.50 stddev:18.63 (14.2%) stddev-sans-first:19.72 15:30:46 INFO - PROCESS | 1680 | Values: 130.0 122.0 133.0 130.0 125.0 107.0 141.0 117.0 163.0 165.0 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:74.00 stddev:11.58 (15.6%) stddev-sans-first:11.95 15:30:46 INFO - PROCESS | 1680 | Values: 67.0 70.0 91.0 91.0 89.0 78.0 64.0 65.0 66.0 65.0 15:30:46 INFO - PROCESS | 1680 | -------- Summary: end -------- 15:30:46 INFO - PROCESS | 1680 | 15:30:46 INFO - TEST-INFO | 1680: exit 0 15:30:46 INFO - TEST-OK | kraken | took 56492ms 15:30:46 INFO - SUITE-END | took 1169s 15:30:47 INFO - Completed test suite (00:19:29) 15:30:47 INFO - javascript benchmark 15:30:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3456.291460250648, 3508.2281897982434, 3517.8065206413653, 3548.2726041161563, 3589.3539162950674, 5347.358317001956, 5557.777688892439, 5728.856778580533, 5744.885102297952, 5763.1355296705515, 5722.284714410699, 5744.195812586241, 5790.971045144779, 5806.332271788746, 5810.883782324351, 5075.187969924813, 5152.252923326116, 5185.0, 5227.47725227478, 5249.86875328116, 5222.686638801665, 5228.320318358608, 5229.633925625208, 5231.319928409321, 5248.658837175591, 5210.973945130269, 5241.8951620967555, 5254.474552544753, 5286.841394758163, 5287.4976877196605, 5285.365756109291, 5296.285001524802, 5322.680639161644, 5347.25138480613, 5347.465253474621, 4164.729292595972, 5191.299174611417, 5206.947930520684, 5224.425313215544, 5230.816921407771, 5657.830265092012, 5694.4590263924865, 5712.11462223356, 5714.057180565202, 5730.656160630376, 6082.480917364355, 6277.089821975834, 6283.214598175228, 6283.96858015707, 6284.402981716729, 5155.561777248939, 6147.631142131487, 6218.347073557256, 6226.968865155691, 6233.438990490878, 5877.970610146965, 5913.88190202421, 5947.226860508106, 5956.2852457704485, 5959.642421454727, 6146.569740118149, 6228.626282423069, 6276.058591211355, 6287.59130656515, 6304.464120549713, 6159.692015399301, 6179.69101544921, 6196.969015154896, 6207.286162091327, 6227.377262273736, 6204.534659900525, 6226.0, 6245.687715614201, 6248.50011999039, 6259.906101408483, 6043.818685439356, 6138.046095287564, 6157.538184636171, 6236.0, 6256.6871656417, 6234.0337247726675, 6234.2830574483605, 6241.188645476059, 6263.6241825490615, 6288.465480434123, 4503.932441013388, 4580.748058856728, 4917.680350777188, 4921.114199444134, 4934.1611925972675, 4168.353905144708, 4349.412829268008, 4409.603135717736, 4441.533638967927, 4464.6428285737065, 5693.259876216065, 5715.828525144252, 5717.599768016199, 5718.085106382959, 5738.540916726652, 6188.009918413032, 6200.689965501707, 6203.47270482005, 6212.223472065992, 6252.374762523802, 5575.665460072409, 5642.0, 5684.062129748628, 5702.45826646468, 5713.4000929902595, 5340.813071542478, 5374.811881584125, 5378.0, 5379.892402152013, 5396.91904621431, 6299.0866324382705, 6327.968360158262, 6340.175777148941, 6356.110144579762, 6371.0, 6139.062858969336, 6149.508039356751, 6193.225846769154, 6239.688015599111, 6243.937560624518, 6347.460465860268, 6351.110844481684, 6358.872822543431, 6361.586496877688, 6377.8724425512155, 6200.410960958701, 6218.968905155445, 6219.409156130341, 6246.500279977682, 6250.281217660027, 6110.801781737137, 6139.246828488627, 6188.412100850412, 6199.349068347939, 6204.81385558434, 5960.0, 6163.38366163398, 6164.229471316085, 6169.81490555284, 6170.784022559189, 5904.439078287556, 6108.4096180878705, 6148.231471066117, 6154.78458253959, 6166.167567378526, 5896.410358964069, 6014.097885317063, 6015.488683461955, 6025.0, 6047.485963693135, 5870.530357571299, 5887.20522729426, 5903.675297858659, 5927.2590926134235, 5932.673702946379, 5060.443351231288, 5763.769449222152, 5785.623934444247, 5794.333651629948, 5807.070868660994], "unit": "score", "name": "dojo.html", "value": 5688.999603954736}, {"lowerIsBetter": false, "replicates": [499.2610935814996, 560.4115678537535, 584.109233419036, 602.0938487576199, 612.292801813905, 31416.528752068738, 34906.77826276081, 39230.2153956921, 39698.0, 40122.0, 44048.0, 45103.77448112763, 45105.32342014872, 45159.77420112903, 45200.773996129974, 9507.80984380312, 9716.951415242915, 9727.562259698296, 9729.805403891918, 9747.074027967332, 7942.880856787153, 9611.471369074698, 9759.219262459023, 9765.0, 9784.217262618973, 9717.174040206592, 9826.0, 9832.803343933118, 9852.408855468659, 9874.555644995957, 9712.514374281292, 9786.804263914717, 9798.314118011742, 9799.853002204973, 9803.0, 9525.761855953588, 9644.807103857953, 9668.70993870185, 9677.70966870995, 9682.903170968271, 40700.0, 40966.590334096574, 41022.0, 41052.589474105174, 41109.38335924934, 3132.9530057049164, 3286.359159963808, 3302.290007648367, 3326.268220991378, 3367.6463971282906, 29068.8546557268, 29175.978840740685, 29292.0, 29581.55627665587, 29835.0, 2789.2608458758446, 2791.860406979643, 2803.8177518461234, 2874.9712502875122, 2915.3149009982635, 396415.0, 401391.0, 401674.0, 402189.0, 403489.0, 67375.0, 67892.98160527596, 68092.0, 68221.31778682249, 68257.65871170712, 69767.65116174489, 75806.62096689481, 76957.0, 77037.0, 77076.22923770691, 18552.07239638013, 18767.155478003522, 18769.155388007573, 18791.0, 18793.718094228596, 14124.293785310694, 14203.218822964836, 14212.71574568503, 14222.0, 14238.0, 21928.671069933964, 22295.44261393478, 22302.776972230393, 22327.441813954458, 22338.329850104525, 7490.4382171337365, 7812.648430820626, 9243.491607961627, 9246.850710265388, 9279.675211367705, 925.3707478914403, 1004.0, 1027.0961553832578, 1043.1029314789275, 1080.1574771678104, 29870.850645746632, 29878.10365689033, 29999.400012000075, 30328.090157295315, 30644.84677576598, 1006.2151521812998, 1083.3066837224183, 1103.5254840418697, 1181.3561608923158, 1182.1606659272013, 15282.465113720966, 15415.460458883885, 15449.845501545065, 15599.220038998004, 15699.764503532457, 537283.0, 542063.0, 542325.0, 542350.0, 542939.0, 49179.262311065366, 59641.0, 61331.0, 61443.38556614466, 61513.0, 1396.8044473773477, 1416.2226405860579, 1506.3070987345725, 1517.1655589425773, 1543.0510236204652, 26421.207363779118, 27205.59191612167, 29071.27321816887, 29175.124746257647, 29875.0, 46973.355932542196, 47321.76339118282, 47383.28925066058, 47421.762891185324, 47496.7625161872, 317320.0, 326844.0, 327037.0, 327918.0, 328419.0, 29615.815367385065, 33913.0, 33994.490082649274, 35010.124746880516, 35018.0, 53619.731901340245, 53821.730891345294, 53999.46000539944, 54582.90834183373, 56053.159202611176, 35552.46671299984, 39672.80163599164, 39696.2060758789, 40781.796091020544, 41366.58633413627, 36262.45606315855, 39448.802755986035, 39741.60258397495, 40323.19353612853, 40540.797296013334, 40446.79776601098, 41570.376444352754, 41800.0, 42416.787916060224, 43389.69830905078, 35470.29059418849, 36065.639343607276, 36580.26839463143, 37203.06992325214, 37391.25217495689, 25156.24531264065, 26755.464890702468, 27720.564709646358, 27977.86011070013, 28103.016394426097], "unit": "score", "name": "ext.html", "value": 20308.744717881567}, {"lowerIsBetter": false, "replicates": [366.7561071887195, 373.3037884345696, 373.90278527582836, 378.9962100378997, 382.0220236195342, 19298.71051934222, 19845.801541984576, 20546.0, 21188.046537905793, 21435.82102984335, 19645.901770491164, 19822.60354792907, 20440.693389599168, 20444.488887777814, 20666.586668266627, 5910.054391297383, 6071.878562428748, 6113.7860174893885, 6115.510759139258, 6135.110408990694, 5817.476427121558, 5964.403559644044, 6010.669413182273, 6052.878942421149, 6055.0, 5925.585209035369, 5947.762089516415, 5961.374055724152, 5962.433568810956, 5963.135345374918, 5746.1955326254565, 5829.679367634779, 5877.324107727623, 5886.941130588682, 5962.701864906738, 5074.5432911037815, 5084.669496482717, 5088.338515992934, 5095.388553373582, 5106.923396149061, 25251.242462726146, 25464.981400744135, 25837.741622583908, 25903.35241618956, 25931.351716207246, 2197.7252843394576, 2430.3073624017247, 2503.4492411669585, 2810.9599448204294, 2836.914892553206, 14812.333444995002, 14987.550373488704, 15059.397624095023, 15069.0, 15217.163056031914, 1598.6882557901097, 1724.5947202407424, 1734.4363081998401, 1781.5100847266976, 1803.998780676724, 101617.4919125407, 103817.44273835898, 103838.88483345511, 104100.47949760202, 104424.0, 8667.4366166199, 11159.442027898573, 11176.441177941071, 11228.27016243958, 11490.195686301879, 13560.660983475493, 13592.0, 13592.048556601141, 13627.977901657217, 13658.863411365957, 7247.420206383476, 8588.699395521127, 8652.610632521551, 8753.912460875437, 8766.517841518651, 8707.912920870836, 8711.47731136134, 8711.782205444788, 8830.0, 8834.86747698785, 5331.733413329318, 6557.967210163919, 6571.408573228432, 6572.572782769104, 6572.967135164389, 1599.6800639872072, 1836.1186630417208, 1839.264294282298, 1870.2332043861952, 1876.626068023951, 760.5322726523259, 930.4510338899946, 933.1601558597316, 1005.9094681478703, 1047.4343854318736, 18245.0, 20343.28798492046, 21277.68083478749, 21587.56824863494, 21811.890940545512, 970.126885802769, 972.6984634763105, 1026.6868605075524, 1057.413135709673, 1063.1919740996743, 11423.143264255048, 11734.647960561197, 11760.235584686969, 11813.291202527877, 12043.638690839289, 502106.4894675503, 534579.327103362, 539510.0, 543421.0, 639113.0, 126487.0, 131974.0, 132363.01455478175, 135401.0, 139753.0, 1019.1744686803713, 1061.193492945367, 1069.2248120112856, 1073.0074680920118, 1074.9462526873624, 18188.272469101088, 18318.72521912199, 18442.631147377244, 18759.906200469457, 19019.90490047541, 33803.83098084494, 42675.7866210667, 45350.77324613356, 51392.0, 53242.208201262074, 55453.44546554483, 74727.2527274742, 76510.23489765031, 76621.0, 77151.0, 7724.536527808349, 7857.371410287277, 7914.0, 7946.284834364704, 7997.800054998672, 9146.314026448175, 12277.0, 12834.358282085672, 13199.604011879659, 13264.336783160996, 10910.509027093642, 11195.664130076111, 11400.543978240778, 11599.942000290283, 11620.883791162318, 10958.45207739594, 11065.723356916142, 11221.102311814871, 11400.48697808584, 11408.600698975495, 11360.1479889007, 11482.25365351283, 11647.708807279547, 11704.005159561533, 11770.999465045224, 7792.259735325361, 7968.083670377749, 7999.440039197433, 8088.919110808816, 8181.427300088937, 9875.358101723652, 11328.263662861887, 11379.317240965569, 11553.884461155281, 11699.473523691284], "unit": "score", "name": "jquery.html", "value": 9670.961090901566}, {"lowerIsBetter": false, "replicates": [1493.0071502450871, 1631.1925596829567, 1672.1221358786636, 1980.8217260446556, 2060.752709674838, 8288.171182881717, 8961.507117108556, 9133.68032118876, 9137.406068605536, 9141.862872056916, 8775.517346545937, 9040.457572545653, 9061.229795467376, 9069.229115525171, 9070.727878163665, 2259.898304576298, 2527.772500474957, 2528.0393450488787, 2559.065940931556, 2578.9097381591646, 2599.922002339933, 2600.219934019796, 2611.3602167468903, 2611.595202743578, 2612.7387261273816, 2465.2480993297036, 2573.987130064347, 2578.2909699832603, 2580.1743442098536, 2582.7417258274118, 2152.9354119376367, 2555.501677172952, 2578.084779903126, 2578.2265320403803, 2584.3280747005724, 2524.507720994407, 2565.615157726337, 2566.525192839331, 2568.845869247851, 2584.3539115221197, 9124.680636177769, 9208.447493150432, 9225.67710130149, 9236.5843537041, 9239.769005774842, 5563.721813909288, 5682.602217844753, 5725.341585717654, 5730.025895597717, 5730.598858079936, 3666.6883314918264, 3720.7023438124884, 3815.313243616148, 3822.789746563938, 3827.5215598050245, 1054.3568423261804, 1055.6991257491577, 1055.841623756435, 1073.0878753059837, 1115.1970581181536, 12388.876111238953, 12413.751724965541, 12436.0, 12444.87996080348, 12471.438785254686, 5007.574356179693, 5013.39839219296, 5097.745112744422, 5130.87172820675, 5133.6919784813035, 10487.685369438928, 10514.631987880388, 10518.789624207473, 10521.3687178768, 10528.842067368996, 5700.686462244534, 5709.74306156224, 5714.228579141846, 5719.942800572025, 5724.112762521816, 4433.445819272591, 4575.22221222393, 4979.30289759434, 5030.673006254582, 5083.796648134034, 4065.8180935346095, 4113.958860411358, 4134.4831896013, 4167.041580436517, 4170.291050521419, 1323.7213040738673, 1331.6587923369884, 1335.5309159924007, 1336.9571734047458, 1338.8887223604386, 1383.2253937794867, 1412.5409241996392, 1435.519101101122, 1441.7332793433247, 1443.8556144385686, 8478.576071196416, 8627.827443451222, 8630.741077767678, 8643.35174861888, 8688.0, 1145.7765735681462, 1207.7161866961258, 1261.4197469164103, 1266.4744131185455, 1277.482619539088, 6421.101045853584, 6501.544891857525, 6539.47684185264, 6541.934580654228, 6546.410823025951, 10840.295380800222, 11158.888411115948, 11260.324380537195, 11279.774404511863, 11306.434678266054, 10838.512266948006, 10895.346279223271, 11075.833862492069, 11119.16606254518, 11157.66527004191, 8592.882925219807, 8644.610992505352, 8732.60703268367, 8752.168543988439, 8767.473951562926, 7011.964940175267, 8106.837863242584, 8167.591620418836, 8171.591420429074, 8264.876026859481, 8398.244158025807, 8974.878140232471, 9809.0, 9973.451460169761, 10083.647072352433, 9781.902180978099, 10017.998200179924, 10041.347312424668, 10193.694189174337, 10217.948910255402, 7247.855042899218, 7265.527740697049, 7269.273072692688, 7334.853302934018, 7350.301721336465, 8314.127016663164, 8338.0, 8379.329653627818, 8391.454555453876, 8398.244158025807, 7480.102387713509, 7718.92281077182, 7755.767326979974, 7812.609369531387, 7829.921700782919, 7500.399968002437, 7543.321101100927, 7576.4317676173405, 7691.2308769124875, 7701.653425595974, 8017.518948863087, 8057.838843222986, 8084.7574572762915, 8088.474249173785, 8099.068607110258, 6974.825629359104, 7225.6387180641805, 7243.891341629775, 7255.09311336083, 7276.05411296528, 7265.564066156047, 7286.526375785769, 7295.051643286339, 7332.743353982585, 7345.853082938204], "unit": "score", "name": "mootools.html", "value": 5137.687930307637}, {"lowerIsBetter": false, "replicates": [327.53980657176663, 329.4432409228404, 333.39156040226595, 334.9765516413851, 338.5311343788853, 6553.606783592988, 6554.868902621956, 6588.209414870216, 6609.933900660998, 6627.072209890607, 6534.248561415438, 6544.738210471587, 6556.934430655692, 6568.901466477994, 6569.605823650584, 4354.956450435487, 4379.146066517031, 4675.859724208262, 4802.375691160144, 4880.829170979016, 4808.206645903421, 4818.229083346665, 4823.493533179018, 4842.515748425165, 4859.538343857328, 4822.348982887301, 4839.346688197101, 4841.298011788289, 4849.636277279201, 4852.49048849871, 4602.424696912886, 4692.0, 4724.291356296549, 4743.762811859393, 4873.195922672755, 4176.958230417687, 4180.707350485467, 4189.0, 4193.748375097504, 4222.387753775716, 6264.937350626481, 6275.968620156916, 6296.087067375205, 6302.275238347557, 6314.400131987454, 5747.339056008529, 5783.450572195635, 5783.5084017858535, 5789.536837053026, 5792.710364481801, 5703.828885133453, 6681.53229273951, 6942.514024018321, 6964.965175174142, 6981.0, 4644.489106198315, 4693.20215563355, 4697.6241900647865, 4711.764411779432, 4734.4081989751285, 5841.3282472515775, 7344.4491663124945, 7358.77923662291, 7361.852762944711, 7394.926050739477, 4762.928556071662, 4790.616750659939, 4796.928046079312, 4812.0, 4813.855584332476, 4857.0, 4860.68405553645, 4864.318995340655, 4865.537773911473, 4875.536824001714, 5757.136429535603, 5765.135229715576, 5781.19063331134, 5791.942080579141, 5801.042827933428, 5697.914531282034, 6715.529912906148, 7001.614911179832, 7021.754238601625, 7041.978913057578, 1664.6753882992941, 1672.7240005399217, 1679.4709666455028, 1682.9915850420668, 1688.0799964019639, 933.5145724223365, 1095.9671209863716, 1111.3276467736903, 1111.6164923101517, 1113.5211858900589, 6254.499640028786, 6403.519736019724, 6406.103145559626, 6412.198475190601, 6439.9356006440275, 7145.428365730729, 7169.175544812413, 7329.340359367576, 7341.229170936975, 7359.264073592598, 6502.869942601122, 6506.446952009038, 6515.4787616990525, 6523.804285871432, 6528.412442880163, 3835.386338185877, 3875.7210120660116, 3882.514685664292, 3882.825272862728, 3882.893375388001, 7400.962995184989, 7679.078510578766, 7680.385569154454, 7696.076470823537, 7697.923020769833, 7555.206703296185, 7556.433267504959, 7571.659275332623, 7574.901639262276, 7602.657880395395, 7627.656755446018, 7632.69469221225, 7634.923650763421, 7636.785332253584, 7648.043994500687, 6266.279377871603, 7010.193827709879, 7051.717931282691, 7288.526245794006, 7329.377002954809, 7144.607046612487, 7219.061522002106, 7219.783406497813, 7227.096612923385, 7231.349178573953, 6217.347178546188, 7508.737194198176, 7638.923610763822, 7639.159692433716, 7646.350060244941, 4829.0, 4836.12949669063, 4839.612830973443, 4839.782209800638, 4848.636352273664, 7020.684069217, 7263.201047884623, 7271.4546409020595, 7272.418206543358, 7289.161746399232, 7039.542429742255, 7096.290370962863, 7132.429405647639, 7134.643267836691, 7170.462215333767, 7038.824029399101, 7062.71749130029, 7082.256363081802, 7090.255523169993, 7102.5028248022145, 6873.037774711444, 6875.243723190545, 6888.655567221719, 6903.792886213421, 6915.896261556181, 6803.523753337417, 7023.157221133497, 7038.8944165838575, 7047.788566343018, 7054.294570542905, 5706.830099829442, 6553.115329430466, 6790.151231096113, 6919.377256046779, 6956.130483689539], "unit": "score", "name": "prototype.html", "value": 5152.207300083694}, {"lowerIsBetter": false, "replicates": [708.4934271995523, 764.3503022430931, 770.6223950264372, 771.4060173666273, 814.5153633588014, 15107.546773596781, 15167.469138580153, 15290.46483373082, 15318.770218446733, 15343.002704824192, 13859.0, 14035.789463158035, 14044.438222471088, 14044.438222471088, 14054.718905621907, 779.6608475313228, 784.4430454377399, 935.0322416299115, 949.5252373813094, 972.4700038479045, 970.5486948568914, 973.2360097323602, 973.4256788494787, 973.7078876337106, 974.2400927276735, 1029.4183786160795, 1030.0780801182937, 1030.1810061001484, 1030.340582027503, 1031.4791030529573, 828.8963879515061, 907.791208022152, 1015.6800607808591, 1015.8222311095602, 1020.1532727835915, 752.6801109528483, 753.9170691223961, 755.0599503617976, 755.2749360613817, 755.5202446446491, 14926.0, 15026.323815428223, 15029.849701503064, 15033.548993530212, 15047.623809404742, 12510.249385036836, 12679.93660031694, 12767.0, 12947.935260323638, 13032.478700851954, 9931.90068099317, 9940.15508681763, 9983.950080249553, 10318.432486213254, 10694.572217111307, 3492.3189977954307, 3539.539859818233, 3555.2178520725397, 3586.910327241814, 3787.0, 74998.0, 75697.62151189263, 76955.84566231455, 76964.46071078604, 77401.0, 9700.126988571063, 9724.319297649097, 9750.853737193947, 9777.511124443748, 9841.704748857546, 22269.331920042423, 23103.0, 23135.53728925412, 23152.305430837103, 23169.0, 7510.0, 7556.58438785872, 7566.508176968479, 7717.614119294013, 7939.285464308125, 4074.4295798587627, 4095.7133000689664, 4116.794160291974, 4170.436991006175, 4394.978025109854, 3731.8880433587037, 3775.6035616259896, 3784.4512545680723, 3787.6780473660046, 3793.2982398256413, 607.1894021481284, 653.1900443450088, 667.7162206062404, 671.4225765841372, 675.0818886314609, 518.2588897876074, 524.0933185588876, 565.2877374508149, 567.4042255631653, 607.9392060793886, 7369.8894516582295, 8195.385346099067, 8277.791327980765, 8333.250007499355, 8374.330053595697, 582.0948425198857, 590.8493334199752, 597.4384078965759, 603.2278683285401, 620.8447888027993, 3785.4511095890944, 3908.1988192420486, 3908.6286802753693, 3921.117748506563, 3973.543042550086, 86668.0, 88722.11277887267, 90451.0, 91018.0, 100714.4964275174, 74737.87893181607, 79090.0, 80018.0, 80525.0, 82142.17857821465, 72225.2777472229, 72846.0, 73358.99999999894, 73658.0, 74306.0, 7240.456965727697, 8344.249017588203, 8510.82978340442, 8703.608337624948, 8814.691485797966, 51638.0, 51764.0, 51805.7409712949, 52014.0, 52080.73959630178, 68394.3160568388, 73621.0, 73872.0, 74459.62770186114, 74699.1325216874, 10902.454877256265, 11057.668269951915, 11188.440577970907, 11434.771304573696, 11523.711907202387, 9410.576524056298, 11812.76374472523, 11886.227395219283, 12087.697807554881, 12171.513139474322, 9399.530023498934, 10826.40454774995, 11699.88300116988, 11752.0, 11815.350155741517, 11720.413979301171, 11882.584109556125, 11884.405779711153, 11916.821247681464, 11980.520779168735, 11055.557777688802, 11341.546338146381, 11396.936189703407, 11462.025727813229, 12139.696507587381, 9430.387024843363, 9561.61753529851, 9731.854022189815, 9854.0, 10059.0, 9399.10708482693, 9797.363171393836, 9805.509724513888, 9826.508674566387, 9905.752356190864], "unit": "score", "name": "yui.html", "value": 7041.044970538688}], "name": "dromaeo_css", "value": 7699.04592648084}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 111.0, 111.0, 111.0, 112.0, 119.0, 111.0, 111.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 140.0, 154.0, 119.0, 137.0, 118.0, 152.0, 142.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 135.4}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 182.0, 185.0, 184.0, 183.0, 184.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.0}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 74.0, 115.0, 56.0, 58.0, 57.0, 58.0, 115.0, 55.0], "unit": "score", "name": "audio-fft", "value": 74.0}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 131.0, 80.0, 78.0, 88.0, 114.0, 76.0, 79.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 94.5}, {"lowerIsBetter": true, "replicates": [90.0, 87.0, 91.0, 87.0, 89.0, 87.0, 92.0, 87.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 95.6}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 87.0, 90.0, 93.0, 141.0, 134.0, 90.0, 89.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 99.1}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 59.0, 58.0, 54.0, 59.0, 83.0, 85.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 62.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 75.0, 73.0, 69.0, 67.0, 65.0, 67.0, 66.0, 63.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 80.0, 79.0, 80.0, 81.0, 80.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.0}, {"lowerIsBetter": true, "replicates": [121.0, 133.0, 133.0, 118.0, 117.0, 123.0, 115.0, 116.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [130.0, 122.0, 133.0, 130.0, 125.0, 107.0, 141.0, 117.0, 163.0, 165.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.3}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 91.0, 91.0, 89.0, 78.0, 64.0, 65.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.6}], "name": "kraken", "value": 1422.2999999999997}]} 15:30:47 INFO - Return code: 0 15:30:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:30:47 INFO - # TBPL SUCCESS # 15:30:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:30:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:30:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:30:47 INFO - 2016-04-01 15:30:47.324 screenresolution[1685:9662] starting screenresolution argv=screenresolution get 15:30:47 INFO - 2016-04-01 15:30:47.326 screenresolution[1685:9662] Display 0: 1600x1200x32@60 15:30:47 INFO - 2016-04-01 15:30:47.332 screenresolution[1686:9665] starting screenresolution argv=screenresolution list 15:30:47 INFO - Available Modes on Display 0 15:30:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:30:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:30:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:30:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:30:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:30:47 INFO - Intel Iris: 15:30:47 INFO - Chipset Model: Intel Iris 15:30:47 INFO - Type: GPU 15:30:47 INFO - Bus: Built-In 15:30:47 INFO - VRAM (Dynamic, Max): 1536 MB 15:30:47 INFO - Vendor: Intel (0x8086) 15:30:47 INFO - Device ID: 0x0a2e 15:30:47 INFO - Revision ID: 0x0009 15:30:47 INFO - Displays: 15:30:47 INFO - Display: 15:30:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:30:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:30:47 INFO - Display Serial Number: 1600x1200 60 15:30:47 INFO - Main Display: Yes 15:30:47 INFO - Mirror: Off 15:30:47 INFO - Online: Yes 15:30:47 INFO - Rotation: Supported 15:30:47 INFO - Return code: 0 15:30:47 INFO - Running post-action listener: _resource_record_post_action 15:30:47 INFO - Running post-run listener: _resource_record_post_run 15:30:48 INFO - Total resource usage - Wall time: 1204s; CPU: 52.0%; Read bytes: 43193856; Write bytes: 666188288; Read time: 606; Write time: 2080 15:30:48 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 351980032; Write bytes: 353351680; Read time: 27975; Write time: 687 15:30:48 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 42272256; Write bytes: 301419520; Read time: 592; Write time: 1354 15:30:48 INFO - Running post-run listener: _upload_blobber_files 15:30:48 INFO - Blob upload gear active. 15:30:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:48 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 15:30:48 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:48 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:50 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:30:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:55 INFO - (blobuploader) - INFO - Done attempting. 15:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:31:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:31:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:31:00 INFO - (blobuploader) - INFO - Done attempting. 15:31:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:31:00 INFO - Return code: 0 15:31:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:31:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:31:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/246622d2950180e188772e769cba5642928fb3111097e8a7815257d4da955b9994ebf25cb00939d77172f814de1f5ed5fe6980ed7389f5cd839ff09f4475be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe7e282778e259d98fd0b0cb10a7e57d343d87970a543f707f79920d3d94b4aca379c1f9f0fa4abfd3c32cf9d2739c1346949e57dc0f0c870096ceb04af3b4b"} 15:31:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:31:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:31:00 INFO - Contents: 15:31:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/246622d2950180e188772e769cba5642928fb3111097e8a7815257d4da955b9994ebf25cb00939d77172f814de1f5ed5fe6980ed7389f5cd839ff09f4475be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe7e282778e259d98fd0b0cb10a7e57d343d87970a543f707f79920d3d94b4aca379c1f9f0fa4abfd3c32cf9d2739c1346949e57dc0f0c870096ceb04af3b4b"} 15:31:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:31:00 INFO - Copying logs to upload dir... 15:31:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:31:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.821630 ========= master_lag: 47.97 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-04-01 15:31:48.615815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-01 15:31:48.619837) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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/Mozilla-Aurora/sha512/246622d2950180e188772e769cba5642928fb3111097e8a7815257d4da955b9994ebf25cb00939d77172f814de1f5ed5fe6980ed7389f5cd839ff09f4475be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe7e282778e259d98fd0b0cb10a7e57d343d87970a543f707f79920d3d94b4aca379c1f9f0fa4abfd3c32cf9d2739c1346949e57dc0f0c870096ceb04af3b4b"} build_url:https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011759 build_url: 'https://queue.taskcluster.net/v1/task/XXUrmU5zR3SnzJ3iz0lalA/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/246622d2950180e188772e769cba5642928fb3111097e8a7815257d4da955b9994ebf25cb00939d77172f814de1f5ed5fe6980ed7389f5cd839ff09f4475be34", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fe7e282778e259d98fd0b0cb10a7e57d343d87970a543f707f79920d3d94b4aca379c1f9f0fa4abfd3c32cf9d2739c1346949e57dc0f0c870096ceb04af3b4b"}' ========= master_lag: 2.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-01 15:31:50.687412) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:31:50.687734) ========= 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.SDTicWI7ed/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.TWpD6EPRY3/Listeners TMPDIR=/var/folders/7m/bcbqjw3n3vg902dvqyjs3pcm00000w/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.005288 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 15:31:50.795766) ========= ========= Started reboot skipped (results: 3, elapsed: 12 secs) (at 2016-04-01 15:31:50.797914) ========= ========= Finished reboot skipped (results: 3, elapsed: 12 secs) (at 2016-04-01 15:32:03.179769) ========= ========= Total master_lag: 50.29 =========