builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0079 starttime: 1457148922.46 results: success (0) buildid: 20160304174429 builduid: d97ebc862c164f08999d7067f4211bf3 revision: 8b57efc1304563764519f2c16b36c4b4af9fe833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 19:35:22.461655) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-04 19:35:22.462089) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-03-04 19:35:22.462384) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005856 basedir: '/builds/slave/test' ========= master_lag: 8.65 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-03-04 19:35:31.122538) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-03-04 19:35:31.122825) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-03-04 19:35:34.892931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-04 19:35:34.893222) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005353 ========= master_lag: 7.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 7 secs) (at 2016-03-04 19:35:42.050932) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 19:35:42.051222) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-04 19:35:42.051577) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-04 19:35:42.051850) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-04 19:35:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-03-04 19:35:43 (45.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.672563 ========= master_lag: 2.72 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-04 19:35:45.448321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-03-04 19:35:45.448627) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.020484 ========= master_lag: 8.46 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 8 secs) (at 2016-03-04 19:35:53.934107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 19:35:53.938431) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8b57efc1304563764519f2c16b36c4b4af9fe833 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8b57efc1304563764519f2c16b36c4b4af9fe833 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-04 19:35:54,054 truncating revision to first 12 chars 2016-03-04 19:35:54,054 Setting DEBUG logging. 2016-03-04 19:35:54,055 attempt 1/10 2016-03-04 19:35:54,055 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8b57efc13045?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-04 19:35:54,347 unpacking tar archive at: fx-team-8b57efc13045/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542733 ========= master_lag: 1.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-04 19:35:55.918109) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-04 19:35:55.918489) ========= echo 8b57efc1304563764519f2c16b36c4b4af9fe833 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8b57efc1304563764519f2c16b36c4b4af9fe833'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 8b57efc1304563764519f2c16b36c4b4af9fe833 program finished with exit code 0 elapsedTime=0.005400 script_repo_revision: '8b57efc1304563764519f2c16b36c4b4af9fe833' ========= master_lag: 1.10 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-04 19:35:57.022295) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 10 secs) (at 2016-03-04 19:35:57.025656) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 10 secs) (at 2016-03-04 19:36:07.225465) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-04 19:36:07.225721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:07 INFO - MultiFileLogger online at 20160304 19:36:07 in /builds/slave/test 19:36:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 19:36:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:36:07 INFO - {'append_to_log': False, 19:36:07 INFO - 'base_work_dir': '/builds/slave/test', 19:36:07 INFO - 'blob_upload_branch': 'Fx-Team', 19:36:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:36:07 INFO - 'branch': 'Fx-Team', 19:36:07 INFO - 'buildbot_json_path': 'buildprops.json', 19:36:07 INFO - 'config_files': ('talos/mac_config.py',), 19:36:07 INFO - 'default_actions': ('clobber', 19:36:07 INFO - 'read-buildbot-config', 19:36:07 INFO - 'download-and-extract', 19:36:07 INFO - 'populate-webroot', 19:36:07 INFO - 'create-virtualenv', 19:36:07 INFO - 'install', 19:36:07 INFO - 'run-tests'), 19:36:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:36:07 INFO - 'download_minidump_stackwalk': True, 19:36:07 INFO - 'download_symbols': 'ondemand', 19:36:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:36:07 INFO - 'tooltool.py': '/tools/tooltool.py', 19:36:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:36:07 INFO - '/tools/misc-python/virtualenv.py')}, 19:36:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:36:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:36:07 INFO - 'installer_path': 'installer.exe', 19:36:07 INFO - 'log_level': 'info', 19:36:07 INFO - 'log_name': 'talos', 19:36:07 INFO - 'log_to_console': True, 19:36:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:36:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:36:07 INFO - 'opt_config_files': (), 19:36:07 INFO - 'pip_index': False, 19:36:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:07 INFO - 'cmd': ('bash', 19:36:07 INFO - '-c', 19:36:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:07 INFO - 'enabled': True, 19:36:07 INFO - 'halt_on_failure': False, 19:36:07 INFO - 'name': 'check_screen_resolution'},), 19:36:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:36:07 INFO - 'cmd': ('bash', 19:36:07 INFO - '-c', 19:36:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:36:07 INFO - 'enabled': True, 19:36:07 INFO - 'halt_on_failure': False, 19:36:07 INFO - 'name': 'check_screen_resolution'},), 19:36:07 INFO - 'run_cmd_checks_enabled': True, 19:36:07 INFO - 'sps_profile': False, 19:36:07 INFO - 'sps_profile_interval': 0, 19:36:07 INFO - 'suite': 'dromaeojs', 19:36:07 INFO - 'system_bits': '32', 19:36:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:36:07 INFO - 'title': 't-yosemite-r7-0079', 19:36:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:36:07 INFO - 'use_talos_json': True, 19:36:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:36:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:36:07 INFO - 'work_dir': 'build'} 19:36:07 INFO - ##### 19:36:07 INFO - ##### Running clobber step. 19:36:07 INFO - ##### 19:36:07 INFO - Running pre-action listener: _resource_record_pre_action 19:36:07 INFO - Running main action method: clobber 19:36:07 INFO - rmtree: /builds/slave/test/build 19:36:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:36:08 INFO - Running post-action listener: _resource_record_post_action 19:36:08 INFO - ##### 19:36:08 INFO - ##### Running read-buildbot-config step. 19:36:08 INFO - ##### 19:36:08 INFO - Running pre-action listener: _resource_record_pre_action 19:36:08 INFO - Running main action method: read_buildbot_config 19:36:08 INFO - Using buildbot properties: 19:36:08 INFO - { 19:36:08 INFO - "project": "", 19:36:08 INFO - "product": "firefox", 19:36:08 INFO - "script_repo_revision": "production", 19:36:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:36:08 INFO - "repository": "", 19:36:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:36:08 INFO - "buildid": "20160304174429", 19:36:08 INFO - "pgo_build": "False", 19:36:08 INFO - "basedir": "/builds/slave/test", 19:36:08 INFO - "buildnumber": 548, 19:36:08 INFO - "slavename": "t-yosemite-r7-0079", 19:36:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:36:08 INFO - "platform": "yosemite_r7", 19:36:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:36:08 INFO - "branch": "fx-team", 19:36:08 INFO - "repo_path": "integration/fx-team", 19:36:08 INFO - "revision": "8b57efc1304563764519f2c16b36c4b4af9fe833", 19:36:08 INFO - "stage_platform": "macosx64", 19:36:08 INFO - "builduid": "d97ebc862c164f08999d7067f4211bf3", 19:36:08 INFO - "slavebuilddir": "test" 19:36:08 INFO - } 19:36:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:36:08 INFO - Running post-action listener: _resource_record_post_action 19:36:08 INFO - ##### 19:36:08 INFO - ##### Running download-and-extract step. 19:36:08 INFO - ##### 19:36:08 INFO - Running pre-action listener: _resource_record_pre_action 19:36:08 INFO - Running main action method: download_and_extract 19:36:08 INFO - mkdir: /builds/slave/test/build/tests 19:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:08 INFO - https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:36:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 19:36:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 19:36:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 19:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 19:36:10 INFO - Downloaded 1277 bytes. 19:36:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 19:36:10 INFO - Using the following test package requirements: 19:36:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:36:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:36:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'jsshell-mac.zip'], 19:36:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:36:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:36:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:36:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:36:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:36:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:36:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:36:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:36:10 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')]} 19:36:10 INFO - https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:36:11 INFO - Downloaded 17860930 bytes. 19:36:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:36:14 INFO - Return code: 0 19:36:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:36:14 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')]} 19:36:14 INFO - https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:36:15 INFO - Downloaded 17860930 bytes. 19:36:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:36:19 INFO - Return code: 0 19:36:19 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')]} 19:36:19 INFO - https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:36:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:36:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:36:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:36:20 INFO - Downloaded 10803659 bytes. 19:36:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:36:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:36:20 INFO - Return code: 0 19:36: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')]} 19:36:20 INFO - https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:36:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 19:36:23 INFO - Downloaded 110936067 bytes. 19:36:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:23 INFO - mkdir: /builds/slave/test/properties 19:36:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:36:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:36:23 INFO - Contents: 19:36:23 INFO - build_url:https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:36:24 INFO - Running post-action listener: _resource_record_post_action 19:36:24 INFO - Running post-action listener: set_extra_try_arguments 19:36:24 INFO - ##### 19:36:24 INFO - ##### Running populate-webroot step. 19:36:24 INFO - ##### 19:36:24 INFO - Running pre-action listener: _resource_record_pre_action 19:36:24 INFO - Running main action method: populate_webroot 19:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:36:24 INFO - '--tppagecycles', 19:36:24 INFO - '7'], 19:36:24 INFO - 'tests': ['tsvgm']}}, 19:36:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:36:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:36:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:36:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:36:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:36:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'tests': ['damp', 'tps']}, 19:36:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['damp', 'tps']}, 19:36:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:36:24 INFO - 'other': {'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'other_l64': {'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'other_nol64': {'tests': ['a11yr', 19:36:24 INFO - 'ts_paint', 19:36:24 INFO - 'tpaint', 19:36:24 INFO - 'sessionrestore', 19:36:24 INFO - 'sessionrestore_no_auto_restore']}, 19:36:24 INFO - 'svgr': {'tests': ['tsvgx', 19:36:24 INFO - 'tsvgr_opacity', 19:36:24 INFO - 'tart', 19:36:24 INFO - 'tscrollx', 19:36:24 INFO - 'cart']}, 19:36:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['tsvgx', 19:36:24 INFO - 'tsvgr_opacity', 19:36:24 INFO - 'tart', 19:36:24 INFO - 'tscrollx', 19:36:24 INFO - 'cart']}, 19:36:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'tests': ['tp5o']}, 19:36:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'talos_options': ['--e10s'], 19:36:24 INFO - 'tests': ['tp5o']}, 19:36:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'talos_options': ['--xperf_path', 19:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:24 INFO - 'tests': ['tp5n']}, 19:36:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:36:24 INFO - 'talos_options': ['--e10s', 19:36:24 INFO - '--xperf_path', 19:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:36:24 INFO - 'tests': ['tp5n']}}, 19:36:24 INFO - 'talos.zip': {'path': '', 19:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:36:24 INFO - Running post-action listener: _resource_record_post_action 19:36:24 INFO - ##### 19:36:24 INFO - ##### Running create-virtualenv step. 19:36:24 INFO - ##### 19:36:24 INFO - Running pre-action listener: _resource_record_pre_action 19:36:24 INFO - Running main action method: create_virtualenv 19:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 19:36:24 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 19:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:36:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:36:24 INFO - Using real prefix '/tools/python27' 19:36:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 19:36:27 INFO - Installing pip.................done. 19:36:27 INFO - Return code: 0 19:36:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:36:27 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')]} 19:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 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')]} 19:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:27 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:27 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 19:36:27 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 19:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:27 INFO - 'HOME': '/Users/cltbld', 19:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:27 INFO - 'LOGNAME': 'cltbld', 19:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:27 INFO - 'MOZ_NO_REMOTE': '1', 19:36:27 INFO - 'NO_EM_RESTART': '1', 19:36:27 INFO - 'PAGER': '/bin/cat', 19:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:27 INFO - 'PWD': '/builds/slave/test', 19:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:27 INFO - 'SHELL': '/bin/bash', 19:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:27 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:27 INFO - 'USER': 'cltbld', 19:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:27 INFO - 'XPC_FLAGS': '0x0', 19:36:27 INFO - 'XPC_SERVICE_NAME': '0', 19:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:28 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 19:36:28 INFO - Cleaning up... 19:36:28 INFO - Return code: 0 19:36:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:28 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:28 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 19:36:28 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 19:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:28 INFO - 'HOME': '/Users/cltbld', 19:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:28 INFO - 'LOGNAME': 'cltbld', 19:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:28 INFO - 'MOZ_NO_REMOTE': '1', 19:36:28 INFO - 'NO_EM_RESTART': '1', 19:36:28 INFO - 'PAGER': '/bin/cat', 19:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:28 INFO - 'PWD': '/builds/slave/test', 19:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:28 INFO - 'SHELL': '/bin/bash', 19:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:28 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:28 INFO - 'USER': 'cltbld', 19:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:28 INFO - 'XPC_FLAGS': '0x0', 19:36:28 INFO - 'XPC_SERVICE_NAME': '0', 19:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:28 INFO - Downloading/unpacking psutil>=0.7.1 19:36:28 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 19:36:28 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 19:36:28 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 19:36:28 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 19:36:28 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 19:36:28 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 19:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:31 INFO - Installing collected packages: psutil 19:36:31 INFO - Running setup.py install for psutil 19:36:31 INFO - building 'psutil._psutil_osx' extension 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 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 19:36:31 INFO - building 'psutil._psutil_posix' extension 19:36:31 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 19:36:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:36:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:36:31 INFO - ^ 19:36:31 INFO - 1 warning generated. 19:36:31 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 19:36:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:36:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:36:32 INFO - Successfully installed psutil 19:36:32 INFO - Cleaning up... 19:36:32 INFO - Return code: 0 19:36:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:36:32 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')]} 19:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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')]} 19:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:32 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:32 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 19:36:32 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 19:36:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:32 INFO - 'HOME': '/Users/cltbld', 19:36:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:32 INFO - 'LOGNAME': 'cltbld', 19:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:32 INFO - 'MOZ_NO_REMOTE': '1', 19:36:32 INFO - 'NO_EM_RESTART': '1', 19:36:32 INFO - 'PAGER': '/bin/cat', 19:36:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:32 INFO - 'PWD': '/builds/slave/test', 19:36:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:32 INFO - 'SHELL': '/bin/bash', 19:36:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:32 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:32 INFO - 'USER': 'cltbld', 19:36:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:32 INFO - 'XPC_FLAGS': '0x0', 19:36:32 INFO - 'XPC_SERVICE_NAME': '0', 19:36:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:32 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 19:36:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:36:34 INFO - Installing collected packages: mozsystemmonitor 19:36:34 INFO - Running setup.py install for mozsystemmonitor 19:36:34 INFO - Successfully installed mozsystemmonitor 19:36:34 INFO - Cleaning up... 19:36:35 INFO - Return code: 0 19:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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', '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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:36: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 blobuploader==1.2.4 19:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:35 INFO - 'HOME': '/Users/cltbld', 19:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:35 INFO - 'LOGNAME': 'cltbld', 19:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:35 INFO - 'MOZ_NO_REMOTE': '1', 19:36:35 INFO - 'NO_EM_RESTART': '1', 19:36:35 INFO - 'PAGER': '/bin/cat', 19:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:35 INFO - 'PWD': '/builds/slave/test', 19:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:35 INFO - 'SHELL': '/bin/bash', 19:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:35 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:35 INFO - 'USER': 'cltbld', 19:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:35 INFO - 'XPC_FLAGS': '0x0', 19:36:35 INFO - 'XPC_SERVICE_NAME': '0', 19:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:37 INFO - Downloading blobuploader-1.2.4.tar.gz 19:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:36:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:36:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36: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 19:36:38 INFO - Downloading docopt-0.6.1.tar.gz 19:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:36:38 INFO - Installing collected packages: blobuploader, requests, docopt 19:36:38 INFO - Running setup.py install for blobuploader 19:36:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:36:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:36:39 INFO - Running setup.py install for requests 19:36:39 INFO - Running setup.py install for docopt 19:36:39 INFO - Successfully installed blobuploader requests docopt 19:36:39 INFO - Cleaning up... 19:36:39 INFO - Return code: 0 19:36:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:39 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:39 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 19:36:39 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 19:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:39 INFO - 'HOME': '/Users/cltbld', 19:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:39 INFO - 'LOGNAME': 'cltbld', 19:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:39 INFO - 'MOZ_NO_REMOTE': '1', 19:36:39 INFO - 'NO_EM_RESTART': '1', 19:36:39 INFO - 'PAGER': '/bin/cat', 19:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:39 INFO - 'PWD': '/builds/slave/test', 19:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:39 INFO - 'SHELL': '/bin/bash', 19:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:39 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:39 INFO - 'USER': 'cltbld', 19:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:39 INFO - 'XPC_FLAGS': '0x0', 19:36:39 INFO - 'XPC_SERVICE_NAME': '0', 19:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Qj9mYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-EyeVM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bGIjsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-OY1CIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ihvLj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-OKyec4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-SUeGtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-WBo76P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9W6MQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:40 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-wavN0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-sYu8jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-SnA_9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-5kwygP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-bbjk3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-PHstke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-RFmUH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:41 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-5vCY1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:36:41 INFO - Running setup.py install for manifestparser 19:36:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:36:41 INFO - Running setup.py install for mozcrash 19:36:42 INFO - Running setup.py install for mozdebug 19:36:42 INFO - Running setup.py install for mozdevice 19:36:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Running setup.py install for mozfile 19:36:42 INFO - Running setup.py install for mozhttpd 19:36:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Running setup.py install for mozinfo 19:36:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Running setup.py install for mozInstall 19:36:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:36:42 INFO - Running setup.py install for mozleak 19:36:43 INFO - Running setup.py install for mozlog 19:36:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Running setup.py install for moznetwork 19:36:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Running setup.py install for mozprocess 19:36:43 INFO - Running setup.py install for mozprofile 19:36:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Running setup.py install for mozrunner 19:36:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:36:43 INFO - Running setup.py install for mozscreenshot 19:36:44 INFO - Running setup.py install for moztest 19:36:44 INFO - Running setup.py install for mozversion 19:36:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:36:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:36:44 INFO - Cleaning up... 19:36:44 INFO - Return code: 0 19:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:44 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:44 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 19:36:44 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 19:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:44 INFO - 'HOME': '/Users/cltbld', 19:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:44 INFO - 'LOGNAME': 'cltbld', 19:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:44 INFO - 'MOZ_NO_REMOTE': '1', 19:36:44 INFO - 'NO_EM_RESTART': '1', 19:36:44 INFO - 'PAGER': '/bin/cat', 19:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:44 INFO - 'PWD': '/builds/slave/test', 19:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:44 INFO - 'SHELL': '/bin/bash', 19:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:44 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:44 INFO - 'USER': 'cltbld', 19:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:44 INFO - 'XPC_FLAGS': '0x0', 19:36:44 INFO - 'XPC_SERVICE_NAME': '0', 19:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:36:44 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-aE4Qvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:36:44 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-W8Tj7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 19:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:36:44 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-9t7rZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:36:44 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)) 19:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-TUe0TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zXMrSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-Q05Uif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-BJYCPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-oiJOgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-SBYV4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-7xh7IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-FpNAYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-ZWspUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:36:45 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)) 19:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:36:45 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-N4MShD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:36:46 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)) 19:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:36:46 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-3hGTTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:36:46 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)) 19:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:46 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-1hmxCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:36:46 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)) 19:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:36:46 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-PS_YqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:36:46 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)) 19:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:36:46 INFO - Running setup.py (path:/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/pip-zHFhRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:36:46 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)) 19:36:46 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:46 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:36:46 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)) 19:36:46 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)) 19:36:46 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)) 19:36:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:36:46 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 19:36:46 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 19:36:46 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 19:36:46 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 19:36:46 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 19:36:46 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 19:36:48 INFO - Downloading blessings-1.6.tar.gz 19:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:36:48 INFO - Installing collected packages: blessings 19:36:48 INFO - Running setup.py install for blessings 19:36:49 INFO - Successfully installed blessings 19:36:49 INFO - Cleaning up... 19:36:49 INFO - Return code: 0 19:36:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:36:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:49 INFO - Reading from file tmpfile_stdout 19:36:49 INFO - Current package versions: 19:36:49 INFO - blessings == 1.6 19:36:49 INFO - blobuploader == 1.2.4 19:36:49 INFO - docopt == 0.6.1 19:36:49 INFO - manifestparser == 1.1 19:36:49 INFO - mozInstall == 1.12 19:36:49 INFO - mozcrash == 0.16 19:36:49 INFO - mozdebug == 0.1 19:36:49 INFO - mozdevice == 0.48 19:36:49 INFO - mozfile == 1.2 19:36:49 INFO - mozhttpd == 0.7 19:36:49 INFO - mozinfo == 0.9 19:36:49 INFO - mozleak == 0.1 19:36:49 INFO - mozlog == 3.1 19:36:49 INFO - moznetwork == 0.27 19:36:49 INFO - mozprocess == 0.22 19:36:49 INFO - mozprofile == 0.28 19:36:49 INFO - mozrunner == 6.11 19:36:49 INFO - mozscreenshot == 0.1 19:36:49 INFO - mozsystemmonitor == 0.0 19:36:49 INFO - moztest == 0.7 19:36:49 INFO - mozversion == 1.4 19:36:49 INFO - psutil == 3.1.1 19:36:49 INFO - requests == 1.2.3 19:36:49 INFO - wsgiref == 0.1.2 19:36:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:49 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:49 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 19:36:49 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 19:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:49 INFO - 'HOME': '/Users/cltbld', 19:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:49 INFO - 'LOGNAME': 'cltbld', 19:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:49 INFO - 'MOZ_NO_REMOTE': '1', 19:36:49 INFO - 'NO_EM_RESTART': '1', 19:36:49 INFO - 'PAGER': '/bin/cat', 19:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:49 INFO - 'PWD': '/builds/slave/test', 19:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:49 INFO - 'SHELL': '/bin/bash', 19:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:49 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:49 INFO - 'USER': 'cltbld', 19:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:49 INFO - 'XPC_FLAGS': '0x0', 19:36:49 INFO - 'XPC_SERVICE_NAME': '0', 19:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 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)) 19:36:49 INFO - Cleaning up... 19:36:49 INFO - Return code: 0 19:36:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:36:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:36:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:49 INFO - 'HOME': '/Users/cltbld', 19:36:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:49 INFO - 'LOGNAME': 'cltbld', 19:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:49 INFO - 'MOZ_NO_REMOTE': '1', 19:36:49 INFO - 'NO_EM_RESTART': '1', 19:36:49 INFO - 'PAGER': '/bin/cat', 19:36:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:49 INFO - 'PWD': '/builds/slave/test', 19:36:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:49 INFO - 'SHELL': '/bin/bash', 19:36:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:49 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:49 INFO - 'USER': 'cltbld', 19:36:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:49 INFO - 'XPC_FLAGS': '0x0', 19:36:49 INFO - 'XPC_SERVICE_NAME': '0', 19:36:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:49 INFO - Downloading/unpacking jsonschema 19:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:36:52 INFO - Downloading/unpacking functools32 (from jsonschema) 19:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:52 INFO - Downloading functools32-3.2.3-2.tar.gz 19:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:36:52 INFO - warning: no files found matching '*.txt' 19:36:52 INFO - no previously-included directories found matching 'build' 19:36:52 INFO - no previously-included directories found matching 'dist' 19:36:52 INFO - no previously-included directories found matching '.git*' 19:36:52 INFO - Installing collected packages: jsonschema, functools32 19:36:52 INFO - Running setup.py install for functools32 19:36:52 INFO - warning: no files found matching '*.txt' 19:36:52 INFO - no previously-included directories found matching 'build' 19:36:52 INFO - no previously-included directories found matching 'dist' 19:36:52 INFO - no previously-included directories found matching '.git*' 19:36:53 INFO - Successfully installed jsonschema functools32 19:36:53 INFO - Cleaning up... 19:36:53 INFO - Return code: 0 19:36:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:36: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')]} 19:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36: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')]} 19:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:36:53 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 0x1029e8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1029f04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa0ad64c00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, '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.luXS4u4Fo4/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.ZycsjjD47R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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 19:36:53 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 19:36:53 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 19:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:36:53 INFO - 'HOME': '/Users/cltbld', 19:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:36:53 INFO - 'LOGNAME': 'cltbld', 19:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:36:53 INFO - 'MOZ_NO_REMOTE': '1', 19:36:53 INFO - 'NO_EM_RESTART': '1', 19:36:53 INFO - 'PAGER': '/bin/cat', 19:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:36:53 INFO - 'PWD': '/builds/slave/test', 19:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:36:53 INFO - 'SHELL': '/bin/bash', 19:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:36:53 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:36:53 INFO - 'USER': 'cltbld', 19:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:36:53 INFO - 'XPC_FLAGS': '0x0', 19:36:53 INFO - 'XPC_SERVICE_NAME': '0', 19:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:36:53 INFO - Downloading/unpacking flake8 19:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:36:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:36:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:36:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 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 19:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:36:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:56 INFO - no previously-included directories found matching 'docs/_build' 19:36:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:36:57 INFO - Running setup.py install for pep8 19:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:36:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:36:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:36:57 INFO - no previously-included directories found matching 'docs/_build' 19:36:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:36:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:36:57 INFO - Cleaning up... 19:36:57 INFO - Return code: 0 19:36:57 INFO - Running post-action listener: _resource_record_post_action 19:36:57 INFO - Running post-action listener: _start_resource_monitoring 19:36:57 INFO - Starting resource monitoring. 19:36:57 INFO - ##### 19:36:57 INFO - ##### Running install step. 19:36:57 INFO - ##### 19:36:57 INFO - Running pre-action listener: _resource_record_pre_action 19:36:57 INFO - Running main action method: install 19:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:36:57 INFO - Reading from file tmpfile_stdout 19:36:57 INFO - Detecting whether we're running mozinstall >=1.0... 19:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:36:57 INFO - Reading from file tmpfile_stdout 19:36:57 INFO - Output received: 19:36:57 INFO - Usage: mozinstall [options] installer 19:36:57 INFO - Options: 19:36:57 INFO - -h, --help show this help message and exit 19:36:57 INFO - -d DEST, --destination=DEST 19:36:57 INFO - Directory to install application into. [default: 19:36:57 INFO - "/builds/slave/test"] 19:36:57 INFO - --app=APP Application being installed. [default: firefox] 19:36:57 INFO - mkdir: /builds/slave/test/build/application 19:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:37:31 INFO - Reading from file tmpfile_stdout 19:37:31 INFO - Output received: 19:37:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:37:31 INFO - Running post-action listener: _resource_record_post_action 19:37:31 INFO - ##### 19:37:31 INFO - ##### Running run-tests step. 19:37:31 INFO - ##### 19:37:31 INFO - Running pre-action listener: _resource_record_pre_action 19:37:31 INFO - Running main action method: run_tests 19:37:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:37:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:37:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:37:31 INFO - 2016-03-04 19:37:31.405 screenresolution[7089:111286] starting screenresolution argv=screenresolution get 19:37:31 INFO - 2016-03-04 19:37:31.408 screenresolution[7089:111286] Display 0: 1600x1200x32@60 19:37:31 INFO - 2016-03-04 19:37:31.413 screenresolution[7090:111288] starting screenresolution argv=screenresolution list 19:37:31 INFO - Available Modes on Display 0 19:37:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:37:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:37:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:37:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:37:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:37:31 INFO - Intel Iris: 19:37:31 INFO - Chipset Model: Intel Iris 19:37:31 INFO - Type: GPU 19:37:31 INFO - Bus: Built-In 19:37:31 INFO - VRAM (Dynamic, Max): 1536 MB 19:37:31 INFO - Vendor: Intel (0x8086) 19:37:31 INFO - Device ID: 0x0a2e 19:37:31 INFO - Revision ID: 0x0009 19:37:31 INFO - Displays: 19:37:31 INFO - Display: 19:37:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:37:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:37:31 INFO - Display Serial Number: 1600x1200 60 19:37:31 INFO - Main Display: Yes 19:37:31 INFO - Mirror: Off 19:37:31 INFO - Online: Yes 19:37:31 INFO - Rotation: Supported 19:37:31 INFO - Return code: 0 19:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:37:31 INFO - Python 2.7.3 19:37:31 INFO - Return code: 0 19:37:31 INFO - grabbing minidump binary from tooltool 19:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:37:31 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 0x10288cd30>, '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 0x1026b0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102883b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:37:31 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 19:37:31 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 19:37:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:37:31 INFO - Return code: 0 19:37:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:37:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:37:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:37:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:37:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:37:32 INFO - Return code: 0 19:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 19:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0079 --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 19:37:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.luXS4u4Fo4/Render', 19:37:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:32 INFO - 'HOME': '/Users/cltbld', 19:37:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:32 INFO - 'LOGNAME': 'cltbld', 19:37:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:37:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:32 INFO - 'MOZ_NO_REMOTE': '1', 19:37:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:37:32 INFO - 'NO_EM_RESTART': '1', 19:37:32 INFO - 'PAGER': '/bin/cat', 19:37:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:32 INFO - 'PWD': '/builds/slave/test', 19:37:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:37:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:32 INFO - 'SHELL': '/bin/bash', 19:37:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZycsjjD47R/Listeners', 19:37:32 INFO - 'TMPDIR': '/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/', 19:37:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:32 INFO - 'USER': 'cltbld', 19:37:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:32 INFO - 'XPC_FLAGS': '0x0', 19:37:32 INFO - 'XPC_SERVICE_NAME': '0', 19:37:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0079', '--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 19:37:33 INFO - mozversion application_buildid: 20160304174429 19:37:33 INFO - mozversion application_changeset: 8b57efc1304563764519f2c16b36c4b4af9fe833 19:37:33 INFO - mozversion application_display_name: Nightly 19:37:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:37:33 INFO - mozversion application_name: Firefox 19:37:33 INFO - mozversion application_remotingname: firefox 19:37:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:37:33 INFO - mozversion application_vendor: Mozilla 19:37:33 INFO - mozversion application_version: 47.0a1 19:37:33 INFO - mozversion platform_buildid: 20160304174429 19:37:33 INFO - mozversion platform_changeset: 8b57efc1304563764519f2c16b36c4b4af9fe833 19:37:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:37:33 INFO - mozversion platform_version: 47.0a1 19:37:33 INFO - using testdate: 1457149053 19:37:33 INFO - actual date: 1457149053 19:37:33 INFO - starting webserver on 'localhost:56859' 19:37:33 INFO - SUITE-START | Running 2 tests 19:37:33 INFO - TEST-START | dromaeo_css 19:37:33 INFO - operating with platform_type : mac_ 19:37:33 INFO - Initialising browser for dromaeo_css test... 19:37:33 INFO - TEST-INFO | started process 7108 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpCSIDdl/profile http://localhost:56859/getInfo.html) 19:37:35 INFO - PROCESS | 7108 | __metrics Screen width/height:1600/1200 19:37:35 INFO - PROCESS | 7108 | colorDepth:24 19:37:35 INFO - PROCESS | 7108 | Browser inner width/height: 1024/689 19:37:35 INFO - PROCESS | 7108 | __metrics 19:37:35 INFO - PROCESS | 7108 | 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" 19:37:35 INFO - PROCESS | 7108 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:37:36 INFO - TEST-INFO | 7108: exit 0 19:37:36 INFO - Browser initialized. 19:37:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:37:36 INFO - TEST-INFO | started process 7111 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpCSIDdl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:37:48 INFO - PROCESS | 7111 | RSS: Main: 245850112 19:37:48 INFO - PROCESS | 7111 | 19:38:39 INFO - PROCESS | 7111 | 1457149119478 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] 19:40:49 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56859/tests/dromaeo/cssquery-ext.html) 19:40:51 INFO - PROCESS | 7111 | RSS: Main: 402649088 19:40:51 INFO - PROCESS | 7111 | 19:43:53 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-ext.html (next: http://localhost:56859/tests/dromaeo/cssquery-jquery.html) 19:43:54 INFO - PROCESS | 7111 | RSS: Main: 381235200 19:43:54 INFO - PROCESS | 7111 | 19:46:56 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56859/tests/dromaeo/cssquery-mootools.html) 19:46:57 INFO - PROCESS | 7111 | RSS: Main: 376131584 19:46:57 INFO - PROCESS | 7111 | 19:49:59 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56859/tests/dromaeo/cssquery-prototype.html) 19:49:59 INFO - PROCESS | 7111 | RSS: Main: 334524416 19:49:59 INFO - PROCESS | 7111 | 19:53:02 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56859/tests/dromaeo/cssquery-yui.html) 19:53:03 INFO - PROCESS | 7111 | RSS: Main: 335151104 19:53:03 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | Cycle 1(1): loaded http://localhost:56859/tests/dromaeo/cssquery-yui.html (next: http://localhost:56859/tests/dromaeo/cssquery-dojo.html) 19:56:06 INFO - PROCESS | 7111 | RSS: Main: 438685696 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | __start_tp_report 19:56:06 INFO - PROCESS | 7111 | _x_x_mozilla_page_load 19:56:06 INFO - PROCESS | 7111 | _x_x_mozilla_page_load_details 19:56:06 INFO - PROCESS | 7111 | |i|pagename|runs| 19:56:06 INFO - PROCESS | 7111 | |0;dojo.html;3004.9182294374027;3380.0704806178305;3384.255463797964;3416.5387672664183;3445.3626079175356;5484.451554844513;5563.527100196478;5598.2162497250365;5608.18681291213;5613.494785469307;5519.69641669709;5585.944140558593;5600.6079574429805;5606.55147588193;5614.3824179340345;4309.719868208572;4813.638977076734;5056.898862022748;5138.743062846861;5149.227615857614;5085.110105731501;5150.639455238135;5166.380034395877;5174.922376164361;5188.37739471264;5135.897282054357;5142.10013247682;5183.818566350178;5196.29849970253;5211.114110601206;5146.536811686948;5205.193195054753;5207.531322181022;5219.034478621467;5255.290535777659;4174.70777045607;5067.0879241736475;5135.845924622267;5141.331626888481;5162.664426812245;5547.362053363874;5555.3611334696625;5561.582881283879;5565.860853478695;5601.411851755548;5188.662736922088;6177.135201071854;6183.505319574423;6188.1027251048345;6194.318624951252;5718.656880587178;6066.8872324311205;6198.194234749454;6232;6234.532410069218;5730.197772311922;5730.799422020209;5750.769969201268;5756.683382413966;5788.073908174756;6211.16149319836;6222.844428889223;6294.118823364733;6295.685215739195;6297.559170858088;5862.970685146547;5977.98374276374;6066.939330606726;6105.419985101408;6116.792316687851;6150.969245153835;6236.781712640036;6241.095041218998;6256.906146407808;6262.060690896402;6180.5673602848265;6194.442500175006;6207.6585787781205;6212.06818977157;6218.253809542884;6053.545984051126;6080.0575910733905;6111.561351782736;6117.979653188387;6203.131561581382;4817.78319975602;4847.321375007502;4852.102361063144;4905.362302900671;4918.581920536794;3982.422548730418;4156.397322388237;4374.321980093091;4377.1683380157665;4434.955650443519;5587.888242235133;5621.437856214346;5622.493975542221;5624.240727501735;5626.240457538262;6107.694615269219;6195.2255968004;6203.31763506014;6207.099970504251;6259.749610015549;5502.449755024546;5567.526760225345;5608.242887210256;5610.18652295423;5611.466910643482;5331.920021199685;5345.1447768356875;5355.116405793001;5373.704446255415;5384.703841288767;6215.844603884849;6259.280182779039;6265.279492858289;6278.591891527036;6298.1812364392335;6112.786052488142;6200.3179650237535;6268.216472940882;6274.749010039547;6287.339829317856;6218.129461875432;6249.156363890998;6282.057691346335;6284.465820405134;6302.527310451826;6093.421124993119;6140.815775526741;6161.599496032743;6183.227096612924;6184.196054512884;6077.20996270482;6169.5064394849205;6250.687465626609;6252.812415627538;6259.6870156492905;5746.080627099644;5842.357340692435;5948.4943779779205;5969.3732158122775;5990.31111422192;6001.339852616296;6015.6691381974415;6024.277086749618;6052.03167493199;6079.969600151971;5799.391063938395;5835.912461312999;5836.9416305838095;5851.473367396955;5851.707414629166;5782.392848750821;5996.190514280691;6045.063015232646;6070.150178974859;6098.159935307505;5880.470757631833;5881.382454842351;5881.794137205177;5891.086881533369;5902.38025007368 19:56:06 INFO - PROCESS | 7111 | |1;ext.html;492.64037252805474;561.8679610291581;562.9248136060123;632.8797528469591;638;24561;30987.69012309876;31011.68988310119;31040.379192416138;39457.21085578287;42397.94005149873;42842;42923.92690182747;42925.78537107318;42929.78535107328;9546.140847323739;9728.708138755848;9778.902210977905;9784.706458806211;9787.706368808947;9572.28207884408;9680.273979451535;9690.612375504972;9703.369280996712;9703.369280996749;9653.613855445774;9725.610975560969;9728.978457261992;9734.756631084208;9835.803283934318;9774.657886973957;9848.359856609297;9852.704418867374;9866.210703143732;9872.35829671069;9625.133737963617;9784.972577879362;9788.070133337322;9792.314537982344;9812.46031468269;41428.79285603583;41764.582354176375;41828.79085604583;41845.79077104625;42069;3225.3226822367333;3255.462848629973;3336.182635254378;3386.2211691311136;3688.2992231475932;29383.70616293831;29682.66428010745;29726.81092756287;30142.54786178209;30359.78560857585;2031.9796802032085;2617.6466177066045;2625.8949642014295;2630.237231202949;2645.2593273883344;475045.62477187737;480554;480591;480624.9999999965;481848.59075704747;45782.771086145025;46696.53303466922;65225;65702.6859462808;65745.67127164429;37229.06927326784;45319;45372;45566.31650525245;45599.08801823945;15465.304061317267;15533.844661553467;15632.06207627546;15635.60910977212;15648;12581.370931453574;12627.747445051047;12648.924841388585;12653.304068276333;12653.493860245488;14812.62968425798;14817.70364592702;14844.628884277763;14887.5533733986;14959.40162393492;5413.350397952192;6313.747450101944;6406.487481001509;6638.834029149213;6672.165979252593;955.1785464500524;962.3215632978734;967.240716037921;975.9560819762986;1121.624255874275;28953.276168095967;29438.852805735834;30042.24894377658;30075.398492030035;30241;1064.9893501065046;1094.6934858239547;1126.9605563805228;1181.9657799425502;1220.4385982447996;14579.854201458062;14651.487197948021;14905.776413353808;14987.950843440854;15131.924340378448;629210;640918;645730;648365;650010;52103.73948130235;57824.42175578191;59386.81226375448;59890.80218395695;59916;1350.716349566602;1462.6489642485726;1475.1075599262506;1486.1083349990136;1494.9850501494846;28674.283142921595;28800.567991479726;29393.706062939953;29479.55780663249;29647.110586682433;47337.289940650226;47494.575162745175;47865.28202077041;48088.038239234316;48160.75919620379;291399;345040.2747986244;346387;346873.2656336702;347239.2638036794;28734.56327183674;32688.346233074728;33080.50379244361;33538.664613353554;33619.15952101217;41763.58236417597;42216.577834221265;42889;43036.569634303254;44599.554004460835;34975.475367868996;36231.913042608765;36451.45322820213;37012.25975480422;37078;35365.82317088398;35591.28817423689;35763.82118089497;36424;36470;29605.85197074001;36503.08742281464;36662.08344791402;38384.42423363596;39341.6065839338;30467.542986854773;31452.685473144975;31644;31675.366492669556;31807.36385272328;23224.883875580515;24182.274531764077;24453.38866528351;24603.630945535475;24685.136020239206 19:56:06 INFO - PROCESS | 7111 | |2;jquery.html;334.77806008070553;349.8950314905529;360.87549795320615;367.1647003068021;368.74188068352163;20170.49573760655;20400.183992640294;20531.897340513297;20950;20984.89507552464;19359.419217423463;20611.587768244626;20793.792062079374;21267.361979140613;21305.57388852222;5827.921834460617;6042.123892035652;6101.328853826076;6122.142899994004;6129.601575897553;4243.8090285937205;4544.477385100706;5970.850728731794;6641.535092543524;6655.667216639173;6393.936060639404;6544.312847151052;6552.868942621145;6592.17597800275;6605.240397354318;6181.443670069692;6468.256150542701;6468.708908099147;6477.870442591146;6521.8043458696075;3772.660460558563;5467.043267428184;5662.159798065645;5686.431356864322;5702.857428564319;10623.57505699771;13467.12463689857;13481.988850836227;14119.647008824759;24465.388365290833;2236.4408897775556;2311.1910831208943;2606.4005278785794;2672.4599726206834;2743.9588406173925;9602.66390676323;9752.21982241419;10111.039451252193;10176;10182.745431364201;1612.7822743929537;1744.3371518822894;1765.5144835170302;1772;1776.085316062229;101096.24471524496;105669;106447.46776266069;107051.92948070576;109440.90559094466;11098.389588572705;11142.888571114185;11148.331100133855;11187.384693841917;11311.547538098548;13660;13763.141975833334;13764.449422023206;13782.793258101137;13791.862081379259;8304.54325012118;8478.660853565789;8490.660373584988;8539.914600854036;8584.74245772628;8618.052014278424;8633.827323453621;8639.740807775777;8712.388208181506;8731.738047858575;3703.685186759156;4405.625521830681;4495.988402609387;4541.954580454153;4555.840545580955;1580.4863419388744;1815.8728888977644;1846.2153584726439;1867.7291792689985;1872.2136702584676;913.8263729891299;923.3167456082585;986.5166068626321;1018.9184865210765;1039.3555995282823;20062.197512099643;20969.26607568758;21136.682949755766;21168.010786247658;21261.893690531757;912.4206129108064;948.9098535639104;961.1781926452783;978.7895602445508;983.6557204978201;10951.671449856518;11335.886641133484;11336.489857956412;11380.943095284636;11389.829152562552;268658;471947;605776;625721;625874;56908.715456422455;75523.62238188773;115673;116020;121117;966.9468179250068;992.6277645882794;1045.7124290820086;1106.618216715232;1107.7009207513927;17276.568085797957;18484.537886552946;18555.90722046381;18725.157367918204;18761.812381876007;51281.48718512767;54062;54263;55448;55578.44421555733;74674.8798768008;76013;76033.61983190049;78237.60881195558;78296.60851695706;7522.623868806429;8209.220124088202;8339.291160251203;8381.245687887875;8389.244967952913;9575.104131374856;10916.727081823017;13504.392302346614;13576.389062492013;13588.04883658174;10101.141402980535;11214;11586.42067896585;11698.649040528799;11914.523419063487;11356.034737047443;11423.885761142283;11572.24780389272;11629.360385178557;11761.529538818351;11576.131790115944;11828.290302581872;11910.166288359731;11951.342676152548;12138.20821211144;8065.758027259191;8089.463002029595;8130;8229.506229626242;8469.449485783405;8743.34424918121;11541.942290288494;11594.88405115938;11674.70813229676;11902.928736413764 19:56:06 INFO - PROCESS | 7111 | |3;mootools.html;1447.131720967419;1595.1705113341059;1622.6998005369003;1906.1612890328254;2033.2680235115356;7929.76210713678;8522.190391912765;8698.782530436742;8702.26030787383;8706.608202630881;8501.91498085019;8748.475091494514;8763.86854197186;8770;8771;2160.6542953127505;2438.158835201861;2490.489449662815;2501.537215615108;2523.2430270918653;2511.573032584465;2512.6231065340253;2519.533886231053;2521.0168034466574;2524.1670248817936;2422.0190822716827;2483.056438553356;2503.5618766715843;2507.4734305795714;2508.435601989556;2432.7080750309988;2472.4066224106264;2476.3932836455006;2479.417336925821;2486.7264600893977;2412.2763171048614;2445.7554244575576;2458.5820410530073;2496.9126080587275;2502.637117617953;8772.956135219347;8817.382783205177;8836.8674469883;8865.379423440361;8871.423357481743;5413.566914646819;5521.199426083195;5528.917066244009;5565.526930210937;5575.749091290902;3482.9651703482896;3577.284543091392;3618.6019537850816;3668.63313668631;3671.596124426311;1016.654337525245;1028.254515476281;1032.1794173631981;1040.287403128859;1043.9112675422598;11997.820032699516;12024.87975120255;12038.879611203864;12043;12064.396780161045;4826.251930950708;4863.7324947128245;4893.412790465096;4961.231009193581;4968.602511799119;10120.392776433437;10128.54421551032;10172.593096276214;10184.338018028804;10187.235957303232;5525.806596769094;5530.695811730394;5544.140658197985;5545.057340252086;5554.944450555443;4403.4495688039;4570.977145114253;4855.6115510759055;4963.60291176705;4967.031428871408;3858.054776579756;3922.7842468663926;3959.8614048508166;3987.441758153861;3998.300297447935;1312.744014917082;1327.8937684985178;1331.474067743236;1337.2645045225088;1340.9061365704308;1151.7178291318512;1365;1381.0884816021378;1389.4858902206047;1395.1629022586367;8149.877751833727;8218.301444377175;8237.46456480327;8257.21556452136;8270.503769773833;1139.1684070628487;1167.6146871532374;1193.2422911451117;1199.4962115911337;1232.7657745028596;6299.96850015747;6354.745810167634;6361.300256971729;6365.2998170201245;6370.426661600478;10028.69913902584;10333.534990925426;10386.948065259625;10495.527701253463;10543.42011189392;8529.360297977677;10044.29689921713;10348.844767328495;10370.118539924191;10384.480775961172;8185.017797864175;8217.465864718893;8252.793680158044;8255.752327430067;8355.289800366916;7699.307062364414;8040.035195776544;8051.758447246592;8165.918340816515;8194.262516373556;9493.620255189715;9502.61989520439;9600.32797704154;9610.135087842127;9724.805503889742;9494.24046076326;9742.415455072718;9786.41281523111;9968.202543796624;9994.20046396301;6494;6627.933720662924;7212.855742885218;7380.815479613053;7509;8138.674453022049;8143.389245806469;8180.754577362689;8190.017197936286;8193.549354785544;7216.71133154689;7322.304381083789;7333.193348731742;7430.665620047002;7440.590767507839;7136.429085673238;7152.856942861218;7191.964040179975;7193.2087470379265;7294.452916031213;7493.325600695964;7704.576248306397;7742.7677169685;7743.845123097619;7745.302922736981;6933.1333583302085;7036.296370362923;7049.471289653194;7052.5063245574365;7054.506184567236;6803.659817009228;7029.824254393681;7044.894326585003;7053.012578239153;7059.752908648173 19:56:06 INFO - PROCESS | 7111 | |4;prototype.html;321.86964279466815;326.31473904799907;330.95201195826616;331.4448299099009;336.6767902813298;5627.915581266284;6101.084837274411;6425.357464253578;6556.27880933097;6597.307282735315;6407.423331900128;6442.387973142544;6456.548041637087;6539.738410463588;6573.408393244607;3796.7152463565203;4636.559526844944;4706.90586188276;4805.831795887145;4880.438749543803;4820;4832.830850920219;4833.7099774013495;4840.685355451885;4840.959193773338;3389.9152521187043;3840.481534992768;3884.39791832265;4763.309320148576;4801.4718380978065;4564.699060767682;4668.85993420198;4770.928436073462;4789.976050119727;4792.544708252711;4118.258713431581;4127.628513433775;4129.855455059089;4131.111810960628;4139.81370838313;5297.47025297471;5930.97034514829;6135.32511423743;6149.108379284979;6157.630542167484;5641.407652196502;5647.943520564783;5659.5755318351285;5659.830205093813;5665.745041473144;6873.759418420382;6880.139982502187;6887.1418361379965;6889.207741109786;6910.550814197111;4469.240229161051;4656.068786242765;4667.323238130486;4667.603253723438;4670.042641258534;5848.73680684366;7117.252688467688;7248.0939882514685;7265.200827908926;7265.527740696838;4477.485089214717;4483.843065492692;4489.708168969007;4491.955080449219;4492.573205545468;4544.863654090383;4554.111948170075;4560.110778398181;4566.908661826745;4569.840055598104;5433.945660543423;5437.564994800486;5443.346798384219;5445.618806683573;5450.836474905759;6700.195976482853;6941.722331106699;6948.930510694829;6970.361964938235;6997.440204783605;1379.4689044717857;1402.845686974432;1684.0316817829796;1690.518202312335;1691.7293233082894;1023.4217667018111;1048.4548035021746;1091.2961140064772;1107.1143085531703;1128.2609890521558;6342.5243106767175;6495.447886929664;6500.642464664489;6505.121808555879;6519.771807986698;5571.554275657938;7096.751613693599;7170.139583249939;7241.131064272321;7261.782146535613;6479.250602337343;6500.317466666026;6507.349265073455;6510.576812507172;6513.153290072355;3794.5446546414605;3836.2135762168687;3838.3091043612417;3847.461355410245;3854.2869569129803;6716.7984960450285;7016.614086225307;7301.89047164293;7324.194338622748;7357.969884216214;5341.7062061586985;7223.819404514929;7391.039164908528;7392.96303518479;7400.5189662671755;7420.666070026862;7422.66598003102;7430.182679905206;7432.62836858155;7436.9256307436235;7167.928320716935;7271.963640181977;7287.708491660274;7289.927100728924;7299.890501642586;6153.800023987412;7130.180029296697;7142.714291428492;7158.856822863618;7166.677499512639;7208.098987626547;7481.625918703934;7508.587027713528;7521.7743467696055;7530.698772049057;4762.452317983476;4783.091212669582;4797.3523574318415;4798.448178459522;4801.855944321676;7178.138623365229;7185.353318201387;7194.856102877809;7201.567905925661;7208.675609597476;6938.410235129869;6963.7465256252335;6969.512134150561;6969.616671083139;6973.895391569029;6701.296363881722;6880.896786548105;6963.4777391694815;6968.860622787414;6975;5552.888942221214;6749.49378796602;6800.659967001531;6805.761798337035;6808.863822723419;6960.164780226405;6975.441964642918;6976.511644184859;6976.895346569907;6981.860362792614;6493;6774.491913106438;6808.863822723617;6812.114425124702;6825.590464572141 19:56:06 INFO - PROCESS | 7111 | |5;yui.html;692.6882902693787;734.6088481991118;748.7632036368499;749.067411073214;771.8726410142327;14642.341094650754;14915.925420372883;15000.924995375008;15004.774928376082;15028.92485537572;13942.581722548315;15763.84236157638;16134.354625814982;16168.9490183138;16184.83815161848;755.8450517643897;763.9847203055936;914.0767824497273;929.707142250189;938.2259635800492;931.5156118818211;946.9384490008161;947.7772723409993;949.2453499467939;953.0612346838393;982.4449186209804;992.7468495533665;993.2897977945768;994.423234523978;994.8109859126779;788.7318311773996;798.3692882622779;802.6428239433454;986.851972204168;990.866233058535;597.5727354941195;720.747738291599;728.9635518224121;734.2840730287927;735.988960165598;15350.539483815503;15401.922990385088;15406.922965385213;15419.460318888785;15459.072455652697;12181.26912385251;12265.080118991022;12312.630621081382;12428;12585.622431327074;8784.297256219486;9838;9846.753831154207;10023.14803241718;10429;3496.7901925884275;3523.7544146696596;3576.123849656825;3632.5822530409077;3679.6872265857432;89000.66499002521;89167;90041;90098.5495072527;90290;9120.726378208665;9304.441733496013;9432.717018489457;9584.616615335448;9593.992630773808;21665.566688666455;21716.674249886266;21743.67384489234;21746.782532174475;21788.128474860827;7162.928370716226;7374.963125184447;7480.925190748023;7493.921154382779;7561.546307221584;4088.6729061674996;4142;4149.336106223051;4159.272127377697;4168.624823765876;3621.873234436835;3668.3947148720695;3673.3387990162028;3676.4485327201132;3684.4657524658774;564.5624640903251;653.7156336993423;661.6691654172913;666.2404858461358;682.6484360554318;526.1975487381774;578.5024878604397;593.608218575738;605.2948315212816;615.6490800243907;8149.551774652451;8194.959025204837;8268.75708839834;8307.916920830714;8336.999560052833;530.0670819357957;548.2215254338848;573.7188777498995;587.309910854744;620.7082671144645;3738.85044598213;3807.200487897517;3845.1540661054523;3937.8621748238675;3949.8222579983394;95947;97683;98223.50888245513;98362;98576;56858;65292.67353663201;84238;84631.15368846232;86238;70524.64737676279;71144.2885571148;72165.63917180485;72750.63624681842;76055;7688.384929205762;7783.299503044526;7860.975621908108;7966.920330796618;7986.12152663195;43508.56491435045;48615;50753.74623127008;52339.98090219674;52708;68976;71601;74761.62619187086;74919;75179.62410187913;11283.296578040789;11498.195126341076;11519.712007199887;11548.769024619629;12190.939045304716;10391.48042597852;12051.457684404048;12059.939700301442;12149.939250304045;12310.753784924073;10915.508802103766;11218.607348742755;11551.480183391599;12085.637430877088;12096.213746106476;11508.59719909799;11538.826917596074;11542.01892839118;11752;11770.3526306054;9533.904660953302;11335;11350.602728904449;11787.057035436974;11880.584179553674;9543.52282385864;9679.441884535407;9717.757056073655;9807.21542276602;9894.604215831287;8819.823603528022;8963.641454341754;9198.724038278862;9215.447073175363;9727.805443891224 19:56:06 INFO - PROCESS | 7111 | __end_tp_report 19:56:06 INFO - PROCESS | 7111 | __start_cc_report 19:56:06 INFO - PROCESS | 7111 | _x_x_mozilla_cycle_collect,1497 19:56:06 INFO - PROCESS | 7111 | __end_cc_report 19:56:06 INFO - PROCESS | 7111 | __startTimestamp1457150166576__endTimestamp 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | ------- Summary: start ------- 19:56:06 INFO - PROCESS | 7111 | Number of tests: 6 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#0] dojo.html Cycles:165 Average:5658.48 Median:5842.36 stddev:662.78 (11.3%) stddev-sans-first:631.28 19:56:06 INFO - PROCESS | 7111 | Values: 3004.9 3380.1 3384.3 3416.5 3445.4 5484.5 5563.5 5598.2 5608.2 5613.5 5519.7 5585.9 5600.6 5606.6 5614.4 4309.7 4813.6 5056.9 5138.7 5149.2 5085.1 5150.6 5166.4 5174.9 5188.4 5135.9 5142.1 5183.8 5196.3 5211.1 5146.5 5205.2 5207.5 5219.0 5255.3 4174.7 5067.1 5135.8 5141.3 5162.7 5547.4 5555.4 5561.6 5565.9 5601.4 5188.7 6177.1 6183.5 6188.1 6194.3 5718.7 6066.9 6198.2 6232.0 6234.5 5730.2 5730.8 5750.8 5756.7 5788.1 6211.2 6222.8 6294.1 6295.7 6297.6 5863.0 5978.0 6066.9 6105.4 6116.8 6151.0 6236.8 6241.1 6256.9 6262.1 6180.6 6194.4 6207.7 6212.1 6218.3 6053.5 6080.1 6111.6 6118.0 6203.1 4817.8 4847.3 4852.1 4905.4 4918.6 3982.4 4156.4 4374.3 4377.2 4435.0 5587.9 5621.4 5622.5 5624.2 5626.2 6107.7 6195.2 6203.3 6207.1 6259.7 5502.4 5567.5 5608.2 5610.2 5611.5 5331.9 5345.1 5355.1 5373.7 5384.7 6215.8 6259.3 6265.3 6278.6 6298.2 6112.8 6200.3 6268.2 6274.7 6287.3 6218.1 6249.2 6282.1 6284.5 6302.5 6093.4 6140.8 6161.6 6183.2 6184.2 6077.2 6169.5 6250.7 6252.8 6259.7 5746.1 5842.4 5948.5 5969.4 5990.3 6001.3 6015.7 6024.3 6052.0 6080.0 5799.4 5835.9 5836.9 5851.5 5851.7 5782.4 5996.2 6045.1 6070.2 6098.2 5880.5 5881.4 5881.8 5891.1 5902.4 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#1] ext.html Cycles:180 Average:62008.16 Median:20350.28 stddev:134330.26 (660.1%) stddev-sans-first:134627.69 19:56:06 INFO - PROCESS | 7111 | Values: 492.6 561.9 562.9 632.9 638.0 24561.0 30987.7 31011.7 31040.4 39457.2 42397.9 42842.0 42923.9 42925.8 42929.8 9546.1 9728.7 9778.9 9784.7 9787.7 9572.3 9680.3 9690.6 9703.4 9703.4 9653.6 9725.6 9729.0 9734.8 9835.8 9774.7 9848.4 9852.7 9866.2 9872.4 9625.1 9785.0 9788.1 9792.3 9812.5 41428.8 41764.6 41828.8 41845.8 42069.0 3225.3 3255.5 3336.2 3386.2 3688.3 29383.7 29682.7 29726.8 30142.5 30359.8 2032.0 2617.6 2625.9 2630.2 2645.3 475045.6 480554.0 480591.0 480625.0 481848.6 45782.8 46696.5 65225.0 65702.7 65745.7 37229.1 45319.0 45372.0 45566.3 45599.1 15465.3 15533.8 15632.1 15635.6 15648.0 12581.4 12627.7 12648.9 12653.3 12653.5 14812.6 14817.7 14844.6 14887.6 14959.4 5413.4 6313.7 6406.5 6638.8 6672.2 955.2 962.3 967.2 976.0 1121.6 28953.3 29438.9 30042.2 30075.4 30241.0 1065.0 1094.7 1127.0 1182.0 1220.4 14579.9 14651.5 14905.8 14988.0 15131.9 629210.0 640918.0 645730.0 648365.0 650010.0 52103.7 57824.4 59386.8 59890.8 59916.0 1350.7 1462.6 1475.1 1486.1 1495.0 28674.3 28800.6 29393.7 29479.6 29647.1 47337.3 47494.6 47865.3 48088.0 48160.8 291399.0 345040.3 346387.0 346873.3 347239.3 28734.6 32688.3 33080.5 33538.7 33619.2 41763.6 42216.6 42889.0 43036.6 44599.6 34975.5 36231.9 36451.5 37012.3 37078.0 35365.8 35591.3 35763.8 36424.0 36470.0 29605.9 36503.1 36662.1 38384.4 39341.6 30467.5 31452.7 31644.0 31675.4 31807.4 23224.9 24182.3 24453.4 24603.6 24685.1 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#2] jquery.html Cycles:180 Average:31402.39 Median:13535.89 stddev:89576.11 (661.8%) stddev-sans-first:89797.02 19:56:06 INFO - PROCESS | 7111 | Values: 334.8 349.9 360.9 367.2 368.7 20170.5 20400.2 20531.9 20950.0 20984.9 19359.4 20611.6 20793.8 21267.4 21305.6 5827.9 6042.1 6101.3 6122.1 6129.6 4243.8 4544.5 5970.9 6641.5 6655.7 6393.9 6544.3 6552.9 6592.2 6605.2 6181.4 6468.3 6468.7 6477.9 6521.8 3772.7 5467.0 5662.2 5686.4 5702.9 10623.6 13467.1 13482.0 14119.6 24465.4 2236.4 2311.2 2606.4 2672.5 2744.0 9602.7 9752.2 10111.0 10176.0 10182.7 1612.8 1744.3 1765.5 1772.0 1776.1 101096.2 105669.0 106447.5 107051.9 109440.9 11098.4 11142.9 11148.3 11187.4 11311.5 13660.0 13763.1 13764.4 13782.8 13791.9 8304.5 8478.7 8490.7 8539.9 8584.7 8618.1 8633.8 8639.7 8712.4 8731.7 3703.7 4405.6 4496.0 4542.0 4555.8 1580.5 1815.9 1846.2 1867.7 1872.2 913.8 923.3 986.5 1018.9 1039.4 20062.2 20969.3 21136.7 21168.0 21261.9 912.4 948.9 961.2 978.8 983.7 10951.7 11335.9 11336.5 11380.9 11389.8 268658.0 471947.0 605776.0 625721.0 625874.0 56908.7 75523.6 115673.0 116020.0 121117.0 966.9 992.6 1045.7 1106.6 1107.7 17276.6 18484.5 18555.9 18725.2 18761.8 51281.5 54062.0 54263.0 55448.0 55578.4 74674.9 76013.0 76033.6 78237.6 78296.6 7522.6 8209.2 8339.3 8381.2 8389.2 9575.1 10916.7 13504.4 13576.4 13588.0 10101.1 11214.0 11586.4 11698.6 11914.5 11356.0 11423.9 11572.2 11629.4 11761.5 11576.1 11828.3 11910.2 11951.3 12138.2 8065.8 8089.5 8130.0 8229.5 8469.4 8743.3 11541.9 11594.9 11674.7 11902.9 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#3] mootools.html Cycles:180 Average:6041.13 Median:5523.50 stddev:3133.38 (56.7%) stddev-sans-first:3123.14 19:56:06 INFO - PROCESS | 7111 | Values: 1447.1 1595.2 1622.7 1906.2 2033.3 7929.8 8522.2 8698.8 8702.3 8706.6 8501.9 8748.5 8763.9 8770.0 8771.0 2160.7 2438.2 2490.5 2501.5 2523.2 2511.6 2512.6 2519.5 2521.0 2524.2 2422.0 2483.1 2503.6 2507.5 2508.4 2432.7 2472.4 2476.4 2479.4 2486.7 2412.3 2445.8 2458.6 2496.9 2502.6 8773.0 8817.4 8836.9 8865.4 8871.4 5413.6 5521.2 5528.9 5565.5 5575.7 3483.0 3577.3 3618.6 3668.6 3671.6 1016.7 1028.3 1032.2 1040.3 1043.9 11997.8 12024.9 12038.9 12043.0 12064.4 4826.3 4863.7 4893.4 4961.2 4968.6 10120.4 10128.5 10172.6 10184.3 10187.2 5525.8 5530.7 5544.1 5545.1 5554.9 4403.4 4571.0 4855.6 4963.6 4967.0 3858.1 3922.8 3959.9 3987.4 3998.3 1312.7 1327.9 1331.5 1337.3 1340.9 1151.7 1365.0 1381.1 1389.5 1395.2 8149.9 8218.3 8237.5 8257.2 8270.5 1139.2 1167.6 1193.2 1199.5 1232.8 6300.0 6354.7 6361.3 6365.3 6370.4 10028.7 10333.5 10386.9 10495.5 10543.4 8529.4 10044.3 10348.8 10370.1 10384.5 8185.0 8217.5 8252.8 8255.8 8355.3 7699.3 8040.0 8051.8 8165.9 8194.3 9493.6 9502.6 9600.3 9610.1 9724.8 9494.2 9742.4 9786.4 9968.2 9994.2 6494.0 6627.9 7212.9 7380.8 7509.0 8138.7 8143.4 8180.8 8190.0 8193.5 7216.7 7322.3 7333.2 7430.7 7440.6 7136.4 7152.9 7192.0 7193.2 7294.5 7493.3 7704.6 7742.8 7743.8 7745.3 6933.1 7036.3 7049.5 7052.5 7054.5 6803.7 7029.8 7044.9 7053.0 7059.8 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#4] prototype.html Cycles:180 Average:5625.71 Median:6449.47 stddev:1802.72 (28.0%) stddev-sans-first:1763.28 19:56:06 INFO - PROCESS | 7111 | Values: 321.9 326.3 331.0 331.4 336.7 5627.9 6101.1 6425.4 6556.3 6597.3 6407.4 6442.4 6456.5 6539.7 6573.4 3796.7 4636.6 4706.9 4805.8 4880.4 4820.0 4832.8 4833.7 4840.7 4841.0 3389.9 3840.5 3884.4 4763.3 4801.5 4564.7 4668.9 4770.9 4790.0 4792.5 4118.3 4127.6 4129.9 4131.1 4139.8 5297.5 5931.0 6135.3 6149.1 6157.6 5641.4 5647.9 5659.6 5659.8 5665.7 6873.8 6880.1 6887.1 6889.2 6910.6 4469.2 4656.1 4667.3 4667.6 4670.0 5848.7 7117.3 7248.1 7265.2 7265.5 4477.5 4483.8 4489.7 4492.0 4492.6 4544.9 4554.1 4560.1 4566.9 4569.8 5433.9 5437.6 5443.3 5445.6 5450.8 6700.2 6941.7 6948.9 6970.4 6997.4 1379.5 1402.8 1684.0 1690.5 1691.7 1023.4 1048.5 1091.3 1107.1 1128.3 6342.5 6495.4 6500.6 6505.1 6519.8 5571.6 7096.8 7170.1 7241.1 7261.8 6479.3 6500.3 6507.3 6510.6 6513.2 3794.5 3836.2 3838.3 3847.5 3854.3 6716.8 7016.6 7301.9 7324.2 7358.0 5341.7 7223.8 7391.0 7393.0 7400.5 7420.7 7422.7 7430.2 7432.6 7436.9 7167.9 7272.0 7287.7 7289.9 7299.9 6153.8 7130.2 7142.7 7158.9 7166.7 7208.1 7481.6 7508.6 7521.8 7530.7 4762.5 4783.1 4797.4 4798.4 4801.9 7178.1 7185.4 7194.9 7201.6 7208.7 6938.4 6963.7 6969.5 6969.6 6973.9 6701.3 6880.9 6963.5 6968.9 6975.0 5552.9 6749.5 6800.7 6805.8 6808.9 6960.2 6975.4 6976.5 6976.9 6981.9 6493.0 6774.5 6808.9 6812.1 6825.6 19:56:06 INFO - PROCESS | 7111 | 19:56:06 INFO - PROCESS | 7111 | [#5] yui.html Cycles:180 Average:18881.79 Median:657.69 stddev:27106.55 (4121.5%) stddev-sans-first:27148.18 19:56:06 INFO - PROCESS | 7111 | Values: 692.7 734.6 748.8 749.1 771.9 14642.3 14915.9 15000.9 15004.8 15028.9 13942.6 15763.8 16134.4 16168.9 16184.8 755.8 764.0 914.1 929.7 938.2 931.5 946.9 947.8 949.2 953.1 982.4 992.7 993.3 994.4 994.8 788.7 798.4 802.6 986.9 990.9 597.6 720.7 729.0 734.3 736.0 15350.5 15401.9 15406.9 15419.5 15459.1 12181.3 12265.1 12312.6 12428.0 12585.6 8784.3 9838.0 9846.8 10023.1 10429.0 3496.8 3523.8 3576.1 3632.6 3679.7 89000.7 89167.0 90041.0 90098.5 90290.0 9120.7 9304.4 9432.7 9584.6 9594.0 21665.6 21716.7 21743.7 21746.8 21788.1 7162.9 7375.0 7480.9 7493.9 7561.5 4088.7 4142.0 4149.3 4159.3 4168.6 3621.9 3668.4 3673.3 3676.4 3684.5 564.6 653.7 661.7 666.2 682.6 526.2 578.5 593.6 605.3 615.6 8149.6 8195.0 8268.8 8307.9 8337.0 530.1 548.2 573.7 587.3 620.7 3738.9 3807.2 3845.2 3937.9 3949.8 95947.0 97683.0 98223.5 98362.0 98576.0 56858.0 65292.7 84238.0 84631.2 86238.0 70524.6 71144.3 72165.6 72750.6 76055.0 7688.4 7783.3 7861.0 7966.9 7986.1 43508.6 48615.0 50753.7 52340.0 52708.0 68976.0 71601.0 74761.6 74919.0 75179.6 11283.3 11498.2 11519.7 11548.8 12190.9 10391.5 12051.5 12059.9 12149.9 12310.8 10915.5 11218.6 11551.5 12085.6 12096.2 11508.6 11538.8 11542.0 11752.0 11770.4 9533.9 11335.0 11350.6 11787.1 11880.6 9543.5 9679.4 9717.8 9807.2 9894.6 8819.8 8963.6 9198.7 9215.4 9727.8 19:56:06 INFO - PROCESS | 7111 | -------- Summary: end -------- 19:56:06 INFO - PROCESS | 7111 | 19:56:07 INFO - TEST-INFO | 7111: exit 0 19:56:07 INFO - TEST-OK | dromaeo_css | took 1113960ms 19:56:07 INFO - TEST-START | kraken 19:56:07 INFO - operating with platform_type : mac_ 19:56:07 INFO - Initialising browser for kraken test... 19:56:07 INFO - TEST-INFO | started process 7114 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpH9Av1W/profile http://localhost:56859/getInfo.html) 19:56:09 INFO - PROCESS | 7114 | __metrics Screen width/height:1600/1200 19:56:09 INFO - PROCESS | 7114 | colorDepth:24 19:56:09 INFO - PROCESS | 7114 | Browser inner width/height: 1024/689 19:56:09 INFO - PROCESS | 7114 | __metrics 19:56:09 INFO - PROCESS | 7114 | 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" 19:56:09 INFO - PROCESS | 7114 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:10 INFO - TEST-INFO | 7114: exit 0 19:56:10 INFO - Browser initialized. 19:56:10 INFO - Running cycle 1/1 for kraken test... 19:56:10 INFO - TEST-INFO | started process 7116 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/tmpH9Av1W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:21 INFO - PROCESS | 7116 | RSS: Main: 245755904 19:56:21 INFO - PROCESS | 7116 | 19:56:24 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56859/tests/kraken/driver.html?testName=audio-beat-detection) 19:56:25 INFO - PROCESS | 7116 | RSS: Main: 291463168 19:56:25 INFO - PROCESS | 7116 | 19:56:27 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56859/tests/kraken/driver.html?testName=audio-dft) 19:56:28 INFO - PROCESS | 7116 | RSS: Main: 301776896 19:56:28 INFO - PROCESS | 7116 | 19:56:31 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56859/tests/kraken/driver.html?testName=audio-fft) 19:56:32 INFO - PROCESS | 7116 | RSS: Main: 285945856 19:56:32 INFO - PROCESS | 7116 | 19:56:34 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56859/tests/kraken/driver.html?testName=audio-oscillator) 19:56:34 INFO - PROCESS | 7116 | RSS: Main: 288944128 19:56:34 INFO - PROCESS | 7116 | 19:56:36 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:56:37 INFO - PROCESS | 7116 | RSS: Main: 288817152 19:56:37 INFO - PROCESS | 7116 | 19:56:40 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56859/tests/kraken/driver.html?testName=imaging-darkroom) 19:56:40 INFO - PROCESS | 7116 | RSS: Main: 289513472 19:56:40 INFO - PROCESS | 7116 | 19:56:43 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56859/tests/kraken/driver.html?testName=imaging-desaturate) 19:56:44 INFO - PROCESS | 7116 | RSS: Main: 290361344 19:56:44 INFO - PROCESS | 7116 | 19:56:47 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56859/tests/kraken/driver.html?testName=json-parse-financial) 19:56:47 INFO - PROCESS | 7116 | RSS: Main: 289939456 19:56:47 INFO - PROCESS | 7116 | 19:56:49 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:56:49 INFO - PROCESS | 7116 | RSS: Main: 325009408 19:56:49 INFO - PROCESS | 7116 | 19:56:51 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:56:52 INFO - PROCESS | 7116 | RSS: Main: 324255744 19:56:52 INFO - PROCESS | 7116 | 19:56:54 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:56:54 INFO - PROCESS | 7116 | RSS: Main: 331698176 19:56:54 INFO - PROCESS | 7116 | 19:56:57 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:56:58 INFO - PROCESS | 7116 | RSS: Main: 333103104 19:56:58 INFO - PROCESS | 7116 | 19:57:00 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:57:01 INFO - PROCESS | 7116 | RSS: Main: 334831616 19:57:01 INFO - PROCESS | 7116 | 19:57:02 INFO - PROCESS | 7116 | Cycle 1(1): loaded http://localhost:56859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56859/tests/kraken/driver.html?testName=ai-astar) 19:57:03 INFO - PROCESS | 7116 | RSS: Main: 394072064 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | __start_tp_report 19:57:03 INFO - PROCESS | 7116 | _x_x_mozilla_page_load 19:57:03 INFO - PROCESS | 7116 | _x_x_mozilla_page_load_details 19:57:03 INFO - PROCESS | 7116 | |i|pagename|runs| 19:57:03 INFO - PROCESS | 7116 | |0;ai-astar;111;110;109;109;111;111;113;109;109;109 19:57:03 INFO - PROCESS | 7116 | |1;audio-beat-detection;161;121;147;161;118;142;141;119;163;120 19:57:03 INFO - PROCESS | 7116 | |2;audio-dft;186;184;184;181;188;186;187;186;182;205 19:57:03 INFO - PROCESS | 7116 | |3;audio-fft;72;79;86;84;73;84;82;103;79;55 19:57:03 INFO - PROCESS | 7116 | |4;audio-oscillator;96;93;131;80;79;89;114;77;79;112 19:57:03 INFO - PROCESS | 7116 | |5;imaging-gaussian-blur;88;86;89;86;88;87;90;85;87;85 19:57:03 INFO - PROCESS | 7116 | |6;imaging-darkroom;149;96;135;148;124;94;94;95;94;94 19:57:03 INFO - PROCESS | 7116 | |7;imaging-desaturate;85;86;85;84;92;88;88;86;83;86 19:57:03 INFO - PROCESS | 7116 | |8;json-parse-financial;56;53;54;53;53;55;53;64;56;52 19:57:03 INFO - PROCESS | 7116 | |9;json-stringify-tinderbox;65;72;72;77;72;69;67;67;68;70 19:57:03 INFO - PROCESS | 7116 | |10;stanford-crypto-aes;82;82;81;83;83;83;83;83;84;84 19:57:03 INFO - PROCESS | 7116 | |11;stanford-crypto-ccm;120;119;122;122;131;124;125;125;121;125 19:57:03 INFO - PROCESS | 7116 | |12;stanford-crypto-pbkdf2;138;126;139;137;144;126;136;138;140;137 19:57:03 INFO - PROCESS | 7116 | |13;stanford-crypto-sha256-iterative;68;65;67;66;66;67;66;67;66;66 19:57:03 INFO - PROCESS | 7116 | __end_tp_report 19:57:03 INFO - PROCESS | 7116 | __start_cc_report 19:57:03 INFO - PROCESS | 7116 | _x_x_mozilla_cycle_collect,1218 19:57:03 INFO - PROCESS | 7116 | __end_cc_report 19:57:03 INFO - PROCESS | 7116 | __startTimestamp1457150223032__endTimestamp 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | ------- Summary: start ------- 19:57:03 INFO - PROCESS | 7116 | Number of tests: 14 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:1.37 (1.2%) stddev-sans-first:1.41 19:57:03 INFO - PROCESS | 7116 | Values: 111.0 110.0 109.0 109.0 111.0 111.0 113.0 109.0 109.0 109.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:144.50 stddev:18.70 (12.9%) stddev-sans-first:18.11 19:57:03 INFO - PROCESS | 7116 | Values: 161.0 121.0 147.0 161.0 118.0 142.0 141.0 119.0 163.0 120.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#2] audio-dft Cycles:10 Average:186.90 Median:186.00 stddev:6.72 (3.6%) stddev-sans-first:7.12 19:57:03 INFO - PROCESS | 7116 | Values: 186.0 184.0 184.0 181.0 188.0 186.0 187.0 186.0 182.0 205.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#3] audio-fft Cycles:10 Average:79.70 Median:80.50 stddev:12.20 (15.2%) stddev-sans-first:12.62 19:57:03 INFO - PROCESS | 7116 | Values: 72.0 79.0 86.0 84.0 73.0 84.0 82.0 103.0 79.0 55.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.50 stddev:18.40 (23.1%) stddev-sans-first:19.52 19:57:03 INFO - PROCESS | 7116 | Values: 96.0 93.0 131.0 80.0 79.0 89.0 114.0 77.0 79.0 112.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.50 stddev:1.66 (1.9%) stddev-sans-first:1.73 19:57:03 INFO - PROCESS | 7116 | Values: 88.0 86.0 89.0 86.0 88.0 87.0 90.0 85.0 87.0 85.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#6] imaging-darkroom Cycles:10 Average:112.30 Median:94.00 stddev:23.99 (25.5%) stddev-sans-first:21.45 19:57:03 INFO - PROCESS | 7116 | Values: 149.0 96.0 135.0 148.0 124.0 94.0 94.0 95.0 94.0 94.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.00 stddev:2.54 (3.0%) stddev-sans-first:2.65 19:57:03 INFO - PROCESS | 7116 | Values: 85.0 86.0 85.0 84.0 92.0 88.0 88.0 86.0 83.0 86.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:3.48 (6.4%) stddev-sans-first:3.67 19:57:03 INFO - PROCESS | 7116 | Values: 56.0 53.0 54.0 53.0 53.0 55.0 53.0 64.0 56.0 52.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:71.00 stddev:3.48 (4.9%) stddev-sans-first:3.21 19:57:03 INFO - PROCESS | 7116 | Values: 65.0 72.0 72.0 77.0 72.0 69.0 67.0 67.0 68.0 70.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 19:57:03 INFO - PROCESS | 7116 | Values: 82.0 82.0 81.0 83.0 83.0 83.0 83.0 83.0 84.0 84.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:124.50 stddev:3.44 (2.8%) stddev-sans-first:3.42 19:57:03 INFO - PROCESS | 7116 | Values: 120.0 119.0 122.0 122.0 131.0 124.0 125.0 125.0 121.0 125.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:138.00 stddev:5.76 (4.2%) stddev-sans-first:6.07 19:57:03 INFO - PROCESS | 7116 | Values: 138.0 126.0 139.0 137.0 144.0 126.0 136.0 138.0 140.0 137.0 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - PROCESS | 7116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:0.84 (1.3%) stddev-sans-first:0.67 19:57:03 INFO - PROCESS | 7116 | Values: 68.0 65.0 67.0 66.0 66.0 67.0 66.0 67.0 66.0 66.0 19:57:03 INFO - PROCESS | 7116 | -------- Summary: end -------- 19:57:03 INFO - PROCESS | 7116 | 19:57:03 INFO - TEST-INFO | 7116: exit 0 19:57:03 INFO - TEST-OK | kraken | took 56695ms 19:57:03 INFO - SUITE-END | took 1170s 19:57:04 INFO - Completed test suite (00:19:31) 19:57:04 INFO - javascript benchmark 19:57:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3004.9182294374027, 3380.0704806178305, 3384.255463797964, 3416.5387672664183, 3445.3626079175356, 5484.451554844513, 5563.527100196478, 5598.2162497250365, 5608.18681291213, 5613.494785469307, 5519.69641669709, 5585.944140558593, 5600.6079574429805, 5606.55147588193, 5614.3824179340345, 4309.719868208572, 4813.638977076734, 5056.898862022748, 5138.743062846861, 5149.227615857614, 5085.110105731501, 5150.639455238135, 5166.380034395877, 5174.922376164361, 5188.37739471264, 5135.897282054357, 5142.10013247682, 5183.818566350178, 5196.29849970253, 5211.114110601206, 5146.536811686948, 5205.193195054753, 5207.531322181022, 5219.034478621467, 5255.290535777659, 4174.70777045607, 5067.0879241736475, 5135.845924622267, 5141.331626888481, 5162.664426812245, 5547.362053363874, 5555.3611334696625, 5561.582881283879, 5565.860853478695, 5601.411851755548, 5188.662736922088, 6177.135201071854, 6183.505319574423, 6188.1027251048345, 6194.318624951252, 5718.656880587178, 6066.8872324311205, 6198.194234749454, 6232.0, 6234.532410069218, 5730.197772311922, 5730.799422020209, 5750.769969201268, 5756.683382413966, 5788.073908174756, 6211.16149319836, 6222.844428889223, 6294.118823364733, 6295.685215739195, 6297.559170858088, 5862.970685146547, 5977.98374276374, 6066.939330606726, 6105.419985101408, 6116.792316687851, 6150.969245153835, 6236.781712640036, 6241.095041218998, 6256.906146407808, 6262.060690896402, 6180.5673602848265, 6194.442500175006, 6207.6585787781205, 6212.06818977157, 6218.253809542884, 6053.545984051126, 6080.0575910733905, 6111.561351782736, 6117.979653188387, 6203.131561581382, 4817.78319975602, 4847.321375007502, 4852.102361063144, 4905.362302900671, 4918.581920536794, 3982.422548730418, 4156.397322388237, 4374.321980093091, 4377.1683380157665, 4434.955650443519, 5587.888242235133, 5621.437856214346, 5622.493975542221, 5624.240727501735, 5626.240457538262, 6107.694615269219, 6195.2255968004, 6203.31763506014, 6207.099970504251, 6259.749610015549, 5502.449755024546, 5567.526760225345, 5608.242887210256, 5610.18652295423, 5611.466910643482, 5331.920021199685, 5345.1447768356875, 5355.116405793001, 5373.704446255415, 5384.703841288767, 6215.844603884849, 6259.280182779039, 6265.279492858289, 6278.591891527036, 6298.1812364392335, 6112.786052488142, 6200.3179650237535, 6268.216472940882, 6274.749010039547, 6287.339829317856, 6218.129461875432, 6249.156363890998, 6282.057691346335, 6284.465820405134, 6302.527310451826, 6093.421124993119, 6140.815775526741, 6161.599496032743, 6183.227096612924, 6184.196054512884, 6077.20996270482, 6169.5064394849205, 6250.687465626609, 6252.812415627538, 6259.6870156492905, 5746.080627099644, 5842.357340692435, 5948.4943779779205, 5969.3732158122775, 5990.31111422192, 6001.339852616296, 6015.6691381974415, 6024.277086749618, 6052.03167493199, 6079.969600151971, 5799.391063938395, 5835.912461312999, 5836.9416305838095, 5851.473367396955, 5851.707414629166, 5782.392848750821, 5996.190514280691, 6045.063015232646, 6070.150178974859, 6098.159935307505, 5880.470757631833, 5881.382454842351, 5881.794137205177, 5891.086881533369, 5902.38025007368], "unit": "score", "name": "dojo.html", "value": 5614.681777188816}, {"lowerIsBetter": false, "replicates": [492.64037252805474, 561.8679610291581, 562.9248136060123, 632.8797528469591, 638.0, 24561.0, 30987.69012309876, 31011.68988310119, 31040.379192416138, 39457.21085578287, 42397.94005149873, 42842.0, 42923.92690182747, 42925.78537107318, 42929.78535107328, 9546.140847323739, 9728.708138755848, 9778.902210977905, 9784.706458806211, 9787.706368808947, 9572.28207884408, 9680.273979451535, 9690.612375504972, 9703.369280996712, 9703.369280996749, 9653.613855445774, 9725.610975560969, 9728.978457261992, 9734.756631084208, 9835.803283934318, 9774.657886973957, 9848.359856609297, 9852.704418867374, 9866.210703143732, 9872.35829671069, 9625.133737963617, 9784.972577879362, 9788.070133337322, 9792.314537982344, 9812.46031468269, 41428.79285603583, 41764.582354176375, 41828.79085604583, 41845.79077104625, 42069.0, 3225.3226822367333, 3255.462848629973, 3336.182635254378, 3386.2211691311136, 3688.2992231475932, 29383.70616293831, 29682.66428010745, 29726.81092756287, 30142.54786178209, 30359.78560857585, 2031.9796802032085, 2617.6466177066045, 2625.8949642014295, 2630.237231202949, 2645.2593273883344, 475045.62477187737, 480554.0, 480591.0, 480624.9999999965, 481848.59075704747, 45782.771086145025, 46696.53303466922, 65225.0, 65702.6859462808, 65745.67127164429, 37229.06927326784, 45319.0, 45372.0, 45566.31650525245, 45599.08801823945, 15465.304061317267, 15533.844661553467, 15632.06207627546, 15635.60910977212, 15648.0, 12581.370931453574, 12627.747445051047, 12648.924841388585, 12653.304068276333, 12653.493860245488, 14812.62968425798, 14817.70364592702, 14844.628884277763, 14887.5533733986, 14959.40162393492, 5413.350397952192, 6313.747450101944, 6406.487481001509, 6638.834029149213, 6672.165979252593, 955.1785464500524, 962.3215632978734, 967.240716037921, 975.9560819762986, 1121.624255874275, 28953.276168095967, 29438.852805735834, 30042.24894377658, 30075.398492030035, 30241.0, 1064.9893501065046, 1094.6934858239547, 1126.9605563805228, 1181.9657799425502, 1220.4385982447996, 14579.854201458062, 14651.487197948021, 14905.776413353808, 14987.950843440854, 15131.924340378448, 629210.0, 640918.0, 645730.0, 648365.0, 650010.0, 52103.73948130235, 57824.42175578191, 59386.81226375448, 59890.80218395695, 59916.0, 1350.716349566602, 1462.6489642485726, 1475.1075599262506, 1486.1083349990136, 1494.9850501494846, 28674.283142921595, 28800.567991479726, 29393.706062939953, 29479.55780663249, 29647.110586682433, 47337.289940650226, 47494.575162745175, 47865.28202077041, 48088.038239234316, 48160.75919620379, 291399.0, 345040.2747986244, 346387.0, 346873.2656336702, 347239.2638036794, 28734.56327183674, 32688.346233074728, 33080.50379244361, 33538.664613353554, 33619.15952101217, 41763.58236417597, 42216.577834221265, 42889.0, 43036.569634303254, 44599.554004460835, 34975.475367868996, 36231.913042608765, 36451.45322820213, 37012.25975480422, 37078.0, 35365.82317088398, 35591.28817423689, 35763.82118089497, 36424.0, 36470.0, 29605.85197074001, 36503.08742281464, 36662.08344791402, 38384.42423363596, 39341.6065839338, 30467.542986854773, 31452.685473144975, 31644.0, 31675.366492669556, 31807.36385272328, 23224.883875580515, 24182.274531764077, 24453.38866528351, 24603.630945535475, 24685.136020239206], "unit": "score", "name": "ext.html", "value": 18969.95876920632}, {"lowerIsBetter": false, "replicates": [334.77806008070553, 349.8950314905529, 360.87549795320615, 367.1647003068021, 368.74188068352163, 20170.49573760655, 20400.183992640294, 20531.897340513297, 20950.0, 20984.89507552464, 19359.419217423463, 20611.587768244626, 20793.792062079374, 21267.361979140613, 21305.57388852222, 5827.921834460617, 6042.123892035652, 6101.328853826076, 6122.142899994004, 6129.601575897553, 4243.8090285937205, 4544.477385100706, 5970.850728731794, 6641.535092543524, 6655.667216639173, 6393.936060639404, 6544.312847151052, 6552.868942621145, 6592.17597800275, 6605.240397354318, 6181.443670069692, 6468.256150542701, 6468.708908099147, 6477.870442591146, 6521.8043458696075, 3772.660460558563, 5467.043267428184, 5662.159798065645, 5686.431356864322, 5702.857428564319, 10623.57505699771, 13467.12463689857, 13481.988850836227, 14119.647008824759, 24465.388365290833, 2236.4408897775556, 2311.1910831208943, 2606.4005278785794, 2672.4599726206834, 2743.9588406173925, 9602.66390676323, 9752.21982241419, 10111.039451252193, 10176.0, 10182.745431364201, 1612.7822743929537, 1744.3371518822894, 1765.5144835170302, 1772.0, 1776.085316062229, 101096.24471524496, 105669.0, 106447.46776266069, 107051.92948070576, 109440.90559094466, 11098.389588572705, 11142.888571114185, 11148.331100133855, 11187.384693841917, 11311.547538098548, 13660.0, 13763.141975833334, 13764.449422023206, 13782.793258101137, 13791.862081379259, 8304.54325012118, 8478.660853565789, 8490.660373584988, 8539.914600854036, 8584.74245772628, 8618.052014278424, 8633.827323453621, 8639.740807775777, 8712.388208181506, 8731.738047858575, 3703.685186759156, 4405.625521830681, 4495.988402609387, 4541.954580454153, 4555.840545580955, 1580.4863419388744, 1815.8728888977644, 1846.2153584726439, 1867.7291792689985, 1872.2136702584676, 913.8263729891299, 923.3167456082585, 986.5166068626321, 1018.9184865210765, 1039.3555995282823, 20062.197512099643, 20969.26607568758, 21136.682949755766, 21168.010786247658, 21261.893690531757, 912.4206129108064, 948.9098535639104, 961.1781926452783, 978.7895602445508, 983.6557204978201, 10951.671449856518, 11335.886641133484, 11336.489857956412, 11380.943095284636, 11389.829152562552, 268658.0, 471947.0, 605776.0, 625721.0, 625874.0, 56908.715456422455, 75523.62238188773, 115673.0, 116020.0, 121117.0, 966.9468179250068, 992.6277645882794, 1045.7124290820086, 1106.618216715232, 1107.7009207513927, 17276.568085797957, 18484.537886552946, 18555.90722046381, 18725.157367918204, 18761.812381876007, 51281.48718512767, 54062.0, 54263.0, 55448.0, 55578.44421555733, 74674.8798768008, 76013.0, 76033.61983190049, 78237.60881195558, 78296.60851695706, 7522.623868806429, 8209.220124088202, 8339.291160251203, 8381.245687887875, 8389.244967952913, 9575.104131374856, 10916.727081823017, 13504.392302346614, 13576.389062492013, 13588.04883658174, 10101.141402980535, 11214.0, 11586.42067896585, 11698.649040528799, 11914.523419063487, 11356.034737047443, 11423.885761142283, 11572.24780389272, 11629.360385178557, 11761.529538818351, 11576.131790115944, 11828.290302581872, 11910.166288359731, 11951.342676152548, 12138.20821211144, 8065.758027259191, 8089.463002029595, 8130.0, 8229.506229626242, 8469.449485783405, 8743.34424918121, 11541.942290288494, 11594.88405115938, 11674.70813229676, 11902.928736413764], "unit": "score", "name": "jquery.html", "value": 9347.073678565665}, {"lowerIsBetter": false, "replicates": [1447.131720967419, 1595.1705113341059, 1622.6998005369003, 1906.1612890328254, 2033.2680235115356, 7929.76210713678, 8522.190391912765, 8698.782530436742, 8702.26030787383, 8706.608202630881, 8501.91498085019, 8748.475091494514, 8763.86854197186, 8770.0, 8771.0, 2160.6542953127505, 2438.158835201861, 2490.489449662815, 2501.537215615108, 2523.2430270918653, 2511.573032584465, 2512.6231065340253, 2519.533886231053, 2521.0168034466574, 2524.1670248817936, 2422.0190822716827, 2483.056438553356, 2503.5618766715843, 2507.4734305795714, 2508.435601989556, 2432.7080750309988, 2472.4066224106264, 2476.3932836455006, 2479.417336925821, 2486.7264600893977, 2412.2763171048614, 2445.7554244575576, 2458.5820410530073, 2496.9126080587275, 2502.637117617953, 8772.956135219347, 8817.382783205177, 8836.8674469883, 8865.379423440361, 8871.423357481743, 5413.566914646819, 5521.199426083195, 5528.917066244009, 5565.526930210937, 5575.749091290902, 3482.9651703482896, 3577.284543091392, 3618.6019537850816, 3668.63313668631, 3671.596124426311, 1016.654337525245, 1028.254515476281, 1032.1794173631981, 1040.287403128859, 1043.9112675422598, 11997.820032699516, 12024.87975120255, 12038.879611203864, 12043.0, 12064.396780161045, 4826.251930950708, 4863.7324947128245, 4893.412790465096, 4961.231009193581, 4968.602511799119, 10120.392776433437, 10128.54421551032, 10172.593096276214, 10184.338018028804, 10187.235957303232, 5525.806596769094, 5530.695811730394, 5544.140658197985, 5545.057340252086, 5554.944450555443, 4403.4495688039, 4570.977145114253, 4855.6115510759055, 4963.60291176705, 4967.031428871408, 3858.054776579756, 3922.7842468663926, 3959.8614048508166, 3987.441758153861, 3998.300297447935, 1312.744014917082, 1327.8937684985178, 1331.474067743236, 1337.2645045225088, 1340.9061365704308, 1151.7178291318512, 1365.0, 1381.0884816021378, 1389.4858902206047, 1395.1629022586367, 8149.877751833727, 8218.301444377175, 8237.46456480327, 8257.21556452136, 8270.503769773833, 1139.1684070628487, 1167.6146871532374, 1193.2422911451117, 1199.4962115911337, 1232.7657745028596, 6299.96850015747, 6354.745810167634, 6361.300256971729, 6365.2998170201245, 6370.426661600478, 10028.69913902584, 10333.534990925426, 10386.948065259625, 10495.527701253463, 10543.42011189392, 8529.360297977677, 10044.29689921713, 10348.844767328495, 10370.118539924191, 10384.480775961172, 8185.017797864175, 8217.465864718893, 8252.793680158044, 8255.752327430067, 8355.289800366916, 7699.307062364414, 8040.035195776544, 8051.758447246592, 8165.918340816515, 8194.262516373556, 9493.620255189715, 9502.61989520439, 9600.32797704154, 9610.135087842127, 9724.805503889742, 9494.24046076326, 9742.415455072718, 9786.41281523111, 9968.202543796624, 9994.20046396301, 6494.0, 6627.933720662924, 7212.855742885218, 7380.815479613053, 7509.0, 8138.674453022049, 8143.389245806469, 8180.754577362689, 8190.017197936286, 8193.549354785544, 7216.71133154689, 7322.304381083789, 7333.193348731742, 7430.665620047002, 7440.590767507839, 7136.429085673238, 7152.856942861218, 7191.964040179975, 7193.2087470379265, 7294.452916031213, 7493.325600695964, 7704.576248306397, 7742.7677169685, 7743.845123097619, 7745.302922736981, 6933.1333583302085, 7036.296370362923, 7049.471289653194, 7052.5063245574365, 7054.506184567236, 6803.659817009228, 7029.824254393681, 7044.894326585003, 7053.012578239153, 7059.752908648173], "unit": "score", "name": "mootools.html", "value": 4958.845995169257}, {"lowerIsBetter": false, "replicates": [321.86964279466815, 326.31473904799907, 330.95201195826616, 331.4448299099009, 336.6767902813298, 5627.915581266284, 6101.084837274411, 6425.357464253578, 6556.27880933097, 6597.307282735315, 6407.423331900128, 6442.387973142544, 6456.548041637087, 6539.738410463588, 6573.408393244607, 3796.7152463565203, 4636.559526844944, 4706.90586188276, 4805.831795887145, 4880.438749543803, 4820.0, 4832.830850920219, 4833.7099774013495, 4840.685355451885, 4840.959193773338, 3389.9152521187043, 3840.481534992768, 3884.39791832265, 4763.309320148576, 4801.4718380978065, 4564.699060767682, 4668.85993420198, 4770.928436073462, 4789.976050119727, 4792.544708252711, 4118.258713431581, 4127.628513433775, 4129.855455059089, 4131.111810960628, 4139.81370838313, 5297.47025297471, 5930.97034514829, 6135.32511423743, 6149.108379284979, 6157.630542167484, 5641.407652196502, 5647.943520564783, 5659.5755318351285, 5659.830205093813, 5665.745041473144, 6873.759418420382, 6880.139982502187, 6887.1418361379965, 6889.207741109786, 6910.550814197111, 4469.240229161051, 4656.068786242765, 4667.323238130486, 4667.603253723438, 4670.042641258534, 5848.73680684366, 7117.252688467688, 7248.0939882514685, 7265.200827908926, 7265.527740696838, 4477.485089214717, 4483.843065492692, 4489.708168969007, 4491.955080449219, 4492.573205545468, 4544.863654090383, 4554.111948170075, 4560.110778398181, 4566.908661826745, 4569.840055598104, 5433.945660543423, 5437.564994800486, 5443.346798384219, 5445.618806683573, 5450.836474905759, 6700.195976482853, 6941.722331106699, 6948.930510694829, 6970.361964938235, 6997.440204783605, 1379.4689044717857, 1402.845686974432, 1684.0316817829796, 1690.518202312335, 1691.7293233082894, 1023.4217667018111, 1048.4548035021746, 1091.2961140064772, 1107.1143085531703, 1128.2609890521558, 6342.5243106767175, 6495.447886929664, 6500.642464664489, 6505.121808555879, 6519.771807986698, 5571.554275657938, 7096.751613693599, 7170.139583249939, 7241.131064272321, 7261.782146535613, 6479.250602337343, 6500.317466666026, 6507.349265073455, 6510.576812507172, 6513.153290072355, 3794.5446546414605, 3836.2135762168687, 3838.3091043612417, 3847.461355410245, 3854.2869569129803, 6716.7984960450285, 7016.614086225307, 7301.89047164293, 7324.194338622748, 7357.969884216214, 5341.7062061586985, 7223.819404514929, 7391.039164908528, 7392.96303518479, 7400.5189662671755, 7420.666070026862, 7422.66598003102, 7430.182679905206, 7432.62836858155, 7436.9256307436235, 7167.928320716935, 7271.963640181977, 7287.708491660274, 7289.927100728924, 7299.890501642586, 6153.800023987412, 7130.180029296697, 7142.714291428492, 7158.856822863618, 7166.677499512639, 7208.098987626547, 7481.625918703934, 7508.587027713528, 7521.7743467696055, 7530.698772049057, 4762.452317983476, 4783.091212669582, 4797.3523574318415, 4798.448178459522, 4801.855944321676, 7178.138623365229, 7185.353318201387, 7194.856102877809, 7201.567905925661, 7208.675609597476, 6938.410235129869, 6963.7465256252335, 6969.512134150561, 6969.616671083139, 6973.895391569029, 6701.296363881722, 6880.896786548105, 6963.4777391694815, 6968.860622787414, 6975.0, 5552.888942221214, 6749.49378796602, 6800.659967001531, 6805.761798337035, 6808.863822723419, 6960.164780226405, 6975.441964642918, 6976.511644184859, 6976.895346569907, 6981.860362792614, 6493.0, 6774.491913106438, 6808.863822723617, 6812.114425124702, 6825.590464572141], "unit": "score", "name": "prototype.html", "value": 5030.352007199012}, {"lowerIsBetter": false, "replicates": [692.6882902693787, 734.6088481991118, 748.7632036368499, 749.067411073214, 771.8726410142327, 14642.341094650754, 14915.925420372883, 15000.924995375008, 15004.774928376082, 15028.92485537572, 13942.581722548315, 15763.84236157638, 16134.354625814982, 16168.9490183138, 16184.83815161848, 755.8450517643897, 763.9847203055936, 914.0767824497273, 929.707142250189, 938.2259635800492, 931.5156118818211, 946.9384490008161, 947.7772723409993, 949.2453499467939, 953.0612346838393, 982.4449186209804, 992.7468495533665, 993.2897977945768, 994.423234523978, 994.8109859126779, 788.7318311773996, 798.3692882622779, 802.6428239433454, 986.851972204168, 990.866233058535, 597.5727354941195, 720.747738291599, 728.9635518224121, 734.2840730287927, 735.988960165598, 15350.539483815503, 15401.922990385088, 15406.922965385213, 15419.460318888785, 15459.072455652697, 12181.26912385251, 12265.080118991022, 12312.630621081382, 12428.0, 12585.622431327074, 8784.297256219486, 9838.0, 9846.753831154207, 10023.14803241718, 10429.0, 3496.7901925884275, 3523.7544146696596, 3576.123849656825, 3632.5822530409077, 3679.6872265857432, 89000.66499002521, 89167.0, 90041.0, 90098.5495072527, 90290.0, 9120.726378208665, 9304.441733496013, 9432.717018489457, 9584.616615335448, 9593.992630773808, 21665.566688666455, 21716.674249886266, 21743.67384489234, 21746.782532174475, 21788.128474860827, 7162.928370716226, 7374.963125184447, 7480.925190748023, 7493.921154382779, 7561.546307221584, 4088.6729061674996, 4142.0, 4149.336106223051, 4159.272127377697, 4168.624823765876, 3621.873234436835, 3668.3947148720695, 3673.3387990162028, 3676.4485327201132, 3684.4657524658774, 564.5624640903251, 653.7156336993423, 661.6691654172913, 666.2404858461358, 682.6484360554318, 526.1975487381774, 578.5024878604397, 593.608218575738, 605.2948315212816, 615.6490800243907, 8149.551774652451, 8194.959025204837, 8268.75708839834, 8307.916920830714, 8336.999560052833, 530.0670819357957, 548.2215254338848, 573.7188777498995, 587.309910854744, 620.7082671144645, 3738.85044598213, 3807.200487897517, 3845.1540661054523, 3937.8621748238675, 3949.8222579983394, 95947.0, 97683.0, 98223.50888245513, 98362.0, 98576.0, 56858.0, 65292.67353663201, 84238.0, 84631.15368846232, 86238.0, 70524.64737676279, 71144.2885571148, 72165.63917180485, 72750.63624681842, 76055.0, 7688.384929205762, 7783.299503044526, 7860.975621908108, 7966.920330796618, 7986.12152663195, 43508.56491435045, 48615.0, 50753.74623127008, 52339.98090219674, 52708.0, 68976.0, 71601.0, 74761.62619187086, 74919.0, 75179.62410187913, 11283.296578040789, 11498.195126341076, 11519.712007199887, 11548.769024619629, 12190.939045304716, 10391.48042597852, 12051.457684404048, 12059.939700301442, 12149.939250304045, 12310.753784924073, 10915.508802103766, 11218.607348742755, 11551.480183391599, 12085.637430877088, 12096.213746106476, 11508.59719909799, 11538.826917596074, 11542.01892839118, 11752.0, 11770.3526306054, 9533.904660953302, 11335.0, 11350.602728904449, 11787.057035436974, 11880.584179553674, 9543.52282385864, 9679.441884535407, 9717.757056073655, 9807.21542276602, 9894.604215831287, 8819.823603528022, 8963.641454341754, 9198.724038278862, 9215.447073175363, 9727.805443891224], "unit": "score", "name": "yui.html", "value": 6971.211351549262}], "name": "dromaeo_css", "value": 7465.600054199296}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 109.0, 109.0, 111.0, 111.0, 113.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [161.0, 121.0, 147.0, 161.0, 118.0, 142.0, 141.0, 119.0, 163.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 139.3}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 184.0, 181.0, 188.0, 186.0, 187.0, 186.0, 182.0, 205.0], "unit": "score", "name": "audio-dft", "value": 186.9}, {"lowerIsBetter": true, "replicates": [72.0, 79.0, 86.0, 84.0, 73.0, 84.0, 82.0, 103.0, 79.0, 55.0], "unit": "score", "name": "audio-fft", "value": 79.7}, {"lowerIsBetter": true, "replicates": [96.0, 93.0, 131.0, 80.0, 79.0, 89.0, 114.0, 77.0, 79.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 95.0}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 87.0, 90.0, 85.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [149.0, 96.0, 135.0, 148.0, 124.0, 94.0, 94.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 112.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 84.0, 92.0, 88.0, 88.0, 86.0, 83.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 54.0, 53.0, 53.0, 55.0, 53.0, 64.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [65.0, 72.0, 72.0, 77.0, 72.0, 69.0, 67.0, 67.0, 68.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 81.0, 83.0, 83.0, 83.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [120.0, 119.0, 122.0, 122.0, 131.0, 124.0, 125.0, 125.0, 121.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [138.0, 126.0, 139.0, 137.0, 144.0, 126.0, 136.0, 138.0, 140.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1430.2}]} 19:57:04 INFO - Return code: 0 19:57:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:57:04 INFO - # TBPL SUCCESS # 19:57:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:57:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:57:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:57:04 INFO - 2016-03-04 19:57:04.358 screenresolution[7120:113573] starting screenresolution argv=screenresolution get 19:57:04 INFO - 2016-03-04 19:57:04.360 screenresolution[7120:113573] Display 0: 1600x1200x32@60 19:57:04 INFO - 2016-03-04 19:57:04.366 screenresolution[7121:113576] starting screenresolution argv=screenresolution list 19:57:04 INFO - Available Modes on Display 0 19:57:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:57:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:57:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:57:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:57:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:57:04 INFO - Intel Iris: 19:57:04 INFO - Chipset Model: Intel Iris 19:57:04 INFO - Type: GPU 19:57:04 INFO - Bus: Built-In 19:57:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:57:04 INFO - Vendor: Intel (0x8086) 19:57:04 INFO - Device ID: 0x0a2e 19:57:04 INFO - Revision ID: 0x0009 19:57:04 INFO - Displays: 19:57:04 INFO - Display: 19:57:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:57:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:57:04 INFO - Display Serial Number: 1600x1200 60 19:57:04 INFO - Main Display: Yes 19:57:04 INFO - Mirror: Off 19:57:04 INFO - Online: Yes 19:57:04 INFO - Rotation: Supported 19:57:04 INFO - Return code: 0 19:57:04 INFO - Running post-action listener: _resource_record_post_action 19:57:04 INFO - Running post-run listener: _resource_record_post_run 19:57:05 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2322432; Write bytes: 705266176; Read time: 41; Write time: 2035 19:57:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401721856; Write bytes: 404014592; Read time: 30160; Write time: 733 19:57:05 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 2322432; Write bytes: 300354560; Read time: 41; Write time: 1298 19:57:05 INFO - Running post-run listener: _upload_blobber_files 19:57:05 INFO - Blob upload gear active. 19:57:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:57:05 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 19:57:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:57:06 INFO - (blobuploader) - INFO - Open directory for files ... 19:57:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:57:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:57:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:07 INFO - (blobuploader) - INFO - Done attempting. 19:57:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:57:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:57:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:57:08 INFO - (blobuploader) - INFO - Done attempting. 19:57:08 INFO - (blobuploader) - INFO - Iteration through files over. 19:57:08 INFO - Return code: 0 19:57:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:57:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:57:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/553fb1a27a2307893b4b7daa19dbb76a53d779c26856f72105c1e3bf821af704806421d4cd16b4f7ba14bafc48965ae952b1d0205bd9d566c894bc911e18308c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207481ccd8777ec7aa96b89eecae1f7ddc367c2a760137ecb376d25d3b7304ace870f9d88856a3cd803a4822176ebbd29cb4a6523d0fe343817b98f2aaf4a5f1"} 19:57:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:57:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:57:08 INFO - Contents: 19:57:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/553fb1a27a2307893b4b7daa19dbb76a53d779c26856f72105c1e3bf821af704806421d4cd16b4f7ba14bafc48965ae952b1d0205bd9d566c894bc911e18308c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207481ccd8777ec7aa96b89eecae1f7ddc367c2a760137ecb376d25d3b7304ace870f9d88856a3cd803a4822176ebbd29cb4a6523d0fe343817b98f2aaf4a5f1"} 19:57:08 INFO - Running post-run listener: copy_logs_to_upload_dir 19:57:08 INFO - Copying logs to upload dir... 19:57:08 INFO - mkdir: /builds/slave/test/build/upload/logs 19:57:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.923157 ========= master_lag: 5.92 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-04 19:57:14.065236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-04 19:57:14.071761) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/553fb1a27a2307893b4b7daa19dbb76a53d779c26856f72105c1e3bf821af704806421d4cd16b4f7ba14bafc48965ae952b1d0205bd9d566c894bc911e18308c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207481ccd8777ec7aa96b89eecae1f7ddc367c2a760137ecb376d25d3b7304ace870f9d88856a3cd803a4822176ebbd29cb4a6523d0fe343817b98f2aaf4a5f1"} build_url:https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/T4RjHXLZQmGiQyC3kh1LPw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/553fb1a27a2307893b4b7daa19dbb76a53d779c26856f72105c1e3bf821af704806421d4cd16b4f7ba14bafc48965ae952b1d0205bd9d566c894bc911e18308c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/207481ccd8777ec7aa96b89eecae1f7ddc367c2a760137ecb376d25d3b7304ace870f9d88856a3cd803a4822176ebbd29cb4a6523d0fe343817b98f2aaf4a5f1"}' ========= master_lag: 1.08 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-04 19:57:15.164406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:57:15.164765) ========= 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.luXS4u4Fo4/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.ZycsjjD47R/Listeners TMPDIR=/var/folders/0d/jvrzwxys08z_8pq41nzpqw_800000w/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.005482 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-04 19:57:15.280902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 19:57:15.281263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-04 19:57:15.284297) ========= ========= Total master_lag: 36.64 =========