builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0105 starttime: 1457430460.32 results: success (0) buildid: 20160307110830 builduid: 3d893880bf6946649cd91a0559a56e1e revision: a06ac8e3220a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.325026) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.326135) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.326903) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005275 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.455030) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.455387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.474793) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.475477) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005140 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.527095) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.527403) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.527778) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.528247) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-08 01:47:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.8M=0s 2016-03-08 01:47:40 (39.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202227 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.750502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.751279) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.025540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:40.803542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-08 01:47:40.804426) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-08 01:47:40,893 Setting DEBUG logging. 2016-03-08 01:47:40,893 attempt 1/10 2016-03-08 01:47:40,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a06ac8e3220a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 01:47:42,615 unpacking tar archive at: mozilla-aurora-a06ac8e3220a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.476362 ========= master_lag: 3.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-03-08 01:47:46.323296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:46.323697) ========= echo a06ac8e3220a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a06ac8e3220a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 a06ac8e3220a program finished with exit code 0 elapsedTime=0.005937 script_repo_revision: 'a06ac8e3220a' ========= master_lag: 0.28 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:46.606511) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:46.606881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:46.629144) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-08 01:47:46.629909) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:47:46 INFO - MultiFileLogger online at 20160308 01:47:46 in /builds/slave/test 01:47:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:47:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:47:46 INFO - {'append_to_log': False, 01:47:46 INFO - 'base_work_dir': '/builds/slave/test', 01:47:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:47:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:47:46 INFO - 'branch': 'Mozilla-Aurora', 01:47:46 INFO - 'buildbot_json_path': 'buildprops.json', 01:47:46 INFO - 'config_files': ('talos/mac_config.py',), 01:47:46 INFO - 'default_actions': ('clobber', 01:47:46 INFO - 'read-buildbot-config', 01:47:46 INFO - 'download-and-extract', 01:47:46 INFO - 'populate-webroot', 01:47:46 INFO - 'create-virtualenv', 01:47:46 INFO - 'install', 01:47:46 INFO - 'run-tests'), 01:47:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:47:46 INFO - 'download_minidump_stackwalk': True, 01:47:46 INFO - 'download_symbols': 'ondemand', 01:47:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:47:46 INFO - 'tooltool.py': '/tools/tooltool.py', 01:47:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:47:46 INFO - '/tools/misc-python/virtualenv.py')}, 01:47:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:47:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:47:46 INFO - 'installer_path': 'installer.exe', 01:47:46 INFO - 'log_level': 'info', 01:47:46 INFO - 'log_name': 'talos', 01:47:46 INFO - 'log_to_console': True, 01:47:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:47:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:47:46 INFO - 'opt_config_files': (), 01:47:46 INFO - 'pip_index': False, 01:47:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:46 INFO - 'cmd': ('bash', 01:47:46 INFO - '-c', 01:47:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:46 INFO - 'enabled': True, 01:47:46 INFO - 'halt_on_failure': False, 01:47:46 INFO - 'name': 'check_screen_resolution'},), 01:47:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:47:46 INFO - 'cmd': ('bash', 01:47:46 INFO - '-c', 01:47:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:47:46 INFO - 'enabled': True, 01:47:46 INFO - 'halt_on_failure': False, 01:47:46 INFO - 'name': 'check_screen_resolution'},), 01:47:46 INFO - 'run_cmd_checks_enabled': True, 01:47:46 INFO - 'sps_profile': False, 01:47:46 INFO - 'sps_profile_interval': 0, 01:47:46 INFO - 'suite': 'dromaeojs', 01:47:46 INFO - 'system_bits': '32', 01:47:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:47:46 INFO - 'title': 't-yosemite-r7-0105', 01:47:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:47:46 INFO - 'use_talos_json': True, 01:47:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:47:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:47:46 INFO - 'work_dir': 'build'} 01:47:46 INFO - ##### 01:47:46 INFO - ##### Running clobber step. 01:47:46 INFO - ##### 01:47:46 INFO - Running pre-action listener: _resource_record_pre_action 01:47:46 INFO - Running main action method: clobber 01:47:46 INFO - rmtree: /builds/slave/test/build 01:47:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:47:48 INFO - Running post-action listener: _resource_record_post_action 01:47:48 INFO - ##### 01:47:48 INFO - ##### Running read-buildbot-config step. 01:47:48 INFO - ##### 01:47:48 INFO - Running pre-action listener: _resource_record_pre_action 01:47:48 INFO - Running main action method: read_buildbot_config 01:47:48 INFO - Using buildbot properties: 01:47:48 INFO - { 01:47:48 INFO - "project": "", 01:47:48 INFO - "product": "firefox", 01:47:48 INFO - "script_repo_revision": "production", 01:47:48 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:47:48 INFO - "repository": "", 01:47:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:47:48 INFO - "buildid": "20160307110830", 01:47:48 INFO - "pgo_build": "False", 01:47:48 INFO - "basedir": "/builds/slave/test", 01:47:48 INFO - "buildnumber": 210, 01:47:48 INFO - "slavename": "t-yosemite-r7-0105", 01:47:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:47:48 INFO - "platform": "yosemite_r7", 01:47:48 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:47:48 INFO - "branch": "mozilla-aurora", 01:47:48 INFO - "repo_path": "releases/mozilla-aurora", 01:47:48 INFO - "revision": "a06ac8e3220a", 01:47:48 INFO - "stage_platform": "macosx64", 01:47:48 INFO - "builduid": "3d893880bf6946649cd91a0559a56e1e", 01:47:48 INFO - "slavebuilddir": "test" 01:47:48 INFO - } 01:47:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:47:48 INFO - Running post-action listener: _resource_record_post_action 01:47:48 INFO - ##### 01:47:48 INFO - ##### Running download-and-extract step. 01:47:48 INFO - ##### 01:47:48 INFO - Running pre-action listener: _resource_record_pre_action 01:47:48 INFO - Running main action method: download_and_extract 01:47:48 INFO - mkdir: /builds/slave/test/build/tests 01:47:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:48 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:47:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:47:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:47:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:47:49 INFO - Downloaded 1277 bytes. 01:47:49 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:47:49 INFO - Using the following test package requirements: 01:47:49 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:47:49 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:47:49 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:47:49 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'jsshell-mac.zip'], 01:47:49 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:47:49 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:47:49 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:47:49 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:47:49 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:47:49 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:47:49 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:47:49 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:47:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:47: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')]} 01:47:49 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:47:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:47:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:47:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:47:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:47:51 INFO - Downloaded 17859094 bytes. 01:47:51 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'] 01:47:51 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 01:47:54 INFO - Return code: 0 01:47:54 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 01:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:54 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:47:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:47:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:47:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:48:03 INFO - Downloaded 17859094 bytes. 01:48:03 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'] 01:48:03 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 01:48:07 INFO - Return code: 0 01:48:07 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')]} 01:48:07 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:48:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:48:08 INFO - Downloaded 10803659 bytes. 01:48:08 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'] 01:48:08 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 01:48:08 INFO - Return code: 0 01:48: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')]} 01:48:08 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:48:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:48:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/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 01:48:12 INFO - Downloaded 110928407 bytes. 01:48:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:12 INFO - mkdir: /builds/slave/test/properties 01:48:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:48:12 INFO - Writing to file /builds/slave/test/properties/build_url 01:48:12 INFO - Contents: 01:48:12 INFO - build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:13 INFO - Running post-action listener: _resource_record_post_action 01:48:13 INFO - Running post-action listener: set_extra_try_arguments 01:48:13 INFO - ##### 01:48:13 INFO - ##### Running populate-webroot step. 01:48:13 INFO - ##### 01:48:13 INFO - Running pre-action listener: _resource_record_pre_action 01:48:13 INFO - Running main action method: populate_webroot 01:48:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:48:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:48:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:48:13 INFO - '--tppagecycles', 01:48:13 INFO - '7'], 01:48:13 INFO - 'tests': ['tsvgm']}}, 01:48:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:48:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:48:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:48:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:48:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'tests': ['damp', 'tps']}, 01:48:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['damp', 'tps']}, 01:48:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:48:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:48:13 INFO - 'other': {'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'other_l64': {'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'other_nol64': {'tests': ['a11yr', 01:48:13 INFO - 'ts_paint', 01:48:13 INFO - 'tpaint', 01:48:13 INFO - 'sessionrestore', 01:48:13 INFO - 'sessionrestore_no_auto_restore']}, 01:48:13 INFO - 'svgr': {'tests': ['tsvgx', 01:48:13 INFO - 'tsvgr_opacity', 01:48:13 INFO - 'tart', 01:48:13 INFO - 'tscrollx', 01:48:13 INFO - 'cart']}, 01:48:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['tsvgx', 01:48:13 INFO - 'tsvgr_opacity', 01:48:13 INFO - 'tart', 01:48:13 INFO - 'tscrollx', 01:48:13 INFO - 'cart']}, 01:48:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'tests': ['tp5o']}, 01:48:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'talos_options': ['--e10s'], 01:48:13 INFO - 'tests': ['tp5o']}, 01:48:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'talos_options': ['--xperf_path', 01:48:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:13 INFO - 'tests': ['tp5n']}, 01:48:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:13 INFO - 'talos_options': ['--e10s', 01:48:13 INFO - '--xperf_path', 01:48:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:13 INFO - 'tests': ['tp5n']}}, 01:48:13 INFO - 'talos.zip': {'path': '', 01:48:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:48:13 INFO - Running post-action listener: _resource_record_post_action 01:48:13 INFO - ##### 01:48:13 INFO - ##### Running create-virtualenv step. 01:48:13 INFO - ##### 01:48:13 INFO - Running pre-action listener: _resource_record_pre_action 01:48:13 INFO - Running main action method: create_virtualenv 01:48:13 INFO - Creating virtualenv /builds/slave/test/build/venv 01:48:13 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 01:48:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:48:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:48:13 INFO - Using real prefix '/tools/python27' 01:48:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:48:14 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:17 INFO - Installing pip.................done. 01:48:17 INFO - Return code: 0 01:48:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:17 INFO - 'HOME': '/Users/cltbld', 01:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:17 INFO - 'LOGNAME': 'cltbld', 01:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:17 INFO - 'MOZ_NO_REMOTE': '1', 01:48:17 INFO - 'NO_EM_RESTART': '1', 01:48:17 INFO - 'PAGER': '/bin/cat', 01:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:17 INFO - 'PWD': '/builds/slave/test', 01:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:17 INFO - 'SHELL': '/bin/bash', 01:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:17 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:17 INFO - 'USER': 'cltbld', 01:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:17 INFO - 'XPC_FLAGS': '0x0', 01:48:17 INFO - 'XPC_SERVICE_NAME': '0', 01:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:17 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 01:48:17 INFO - Cleaning up... 01:48:17 INFO - Return code: 0 01:48:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:48:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:48:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:17 INFO - 'HOME': '/Users/cltbld', 01:48:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:17 INFO - 'LOGNAME': 'cltbld', 01:48:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:17 INFO - 'MOZ_NO_REMOTE': '1', 01:48:17 INFO - 'NO_EM_RESTART': '1', 01:48:17 INFO - 'PAGER': '/bin/cat', 01:48:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:17 INFO - 'PWD': '/builds/slave/test', 01:48:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:17 INFO - 'SHELL': '/bin/bash', 01:48:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:17 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:17 INFO - 'USER': 'cltbld', 01:48:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:17 INFO - 'XPC_FLAGS': '0x0', 01:48:17 INFO - 'XPC_SERVICE_NAME': '0', 01:48:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:18 INFO - Downloading/unpacking psutil>=0.7.1 01:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:23 INFO - Installing collected packages: psutil 01:48:23 INFO - Running setup.py install for psutil 01:48:23 INFO - building 'psutil._psutil_osx' extension 01:48:23 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 01:48:23 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 01:48:23 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 01:48:23 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 01:48:23 INFO - building 'psutil._psutil_posix' extension 01:48:23 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 01:48:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:48:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:48:24 INFO - ^ 01:48:24 INFO - 1 warning generated. 01:48:24 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 01:48:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:24 INFO - Successfully installed psutil 01:48:24 INFO - Cleaning up... 01:48:24 INFO - Return code: 0 01:48:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:48:24 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')]} 01:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:24 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')]} 01:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:24 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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:24 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 01:48:24 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 01:48:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:24 INFO - 'HOME': '/Users/cltbld', 01:48:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:24 INFO - 'LOGNAME': 'cltbld', 01:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:24 INFO - 'MOZ_NO_REMOTE': '1', 01:48:24 INFO - 'NO_EM_RESTART': '1', 01:48:24 INFO - 'PAGER': '/bin/cat', 01:48:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:24 INFO - 'PWD': '/builds/slave/test', 01:48:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:24 INFO - 'SHELL': '/bin/bash', 01:48:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:24 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:24 INFO - 'USER': 'cltbld', 01:48:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:24 INFO - 'XPC_FLAGS': '0x0', 01:48:24 INFO - 'XPC_SERVICE_NAME': '0', 01:48:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:48:24 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 01:48:24 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 01:48:24 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 01:48:24 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 01:48:24 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 01:48:24 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 01:48:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:48:27 INFO - Installing collected packages: mozsystemmonitor 01:48:27 INFO - Running setup.py install for mozsystemmonitor 01:48:28 INFO - Successfully installed mozsystemmonitor 01:48:28 INFO - Cleaning up... 01:48:28 INFO - Return code: 0 01:48:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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', '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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:48: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 blobuploader==1.2.4 01:48:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:28 INFO - 'HOME': '/Users/cltbld', 01:48:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:28 INFO - 'LOGNAME': 'cltbld', 01:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:28 INFO - 'MOZ_NO_REMOTE': '1', 01:48:28 INFO - 'NO_EM_RESTART': '1', 01:48:28 INFO - 'PAGER': '/bin/cat', 01:48:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:28 INFO - 'PWD': '/builds/slave/test', 01:48:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:28 INFO - 'SHELL': '/bin/bash', 01:48:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:28 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:28 INFO - 'USER': 'cltbld', 01:48:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:28 INFO - 'XPC_FLAGS': '0x0', 01:48:28 INFO - 'XPC_SERVICE_NAME': '0', 01:48:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:31 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:48:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48: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 01:48:33 INFO - Downloading docopt-0.6.1.tar.gz 01:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:33 INFO - Running setup.py install for blobuploader 01:48:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:48:33 INFO - Running setup.py install for requests 01:48:33 INFO - Running setup.py install for docopt 01:48:33 INFO - Successfully installed blobuploader requests docopt 01:48:33 INFO - Cleaning up... 01:48:34 INFO - Return code: 0 01:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:34 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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:34 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 01:48:34 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 01:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:34 INFO - 'HOME': '/Users/cltbld', 01:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:34 INFO - 'LOGNAME': 'cltbld', 01:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:34 INFO - 'MOZ_NO_REMOTE': '1', 01:48:34 INFO - 'NO_EM_RESTART': '1', 01:48:34 INFO - 'PAGER': '/bin/cat', 01:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:34 INFO - 'PWD': '/builds/slave/test', 01:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:34 INFO - 'SHELL': '/bin/bash', 01:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:34 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:34 INFO - 'USER': 'cltbld', 01:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:34 INFO - 'XPC_FLAGS': '0x0', 01:48:34 INFO - 'XPC_SERVICE_NAME': '0', 01:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MH8JqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6tiXD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-XfpNPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-OnQL8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_dVX4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-unVaF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-1OkfY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:34 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MFnS6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-crdXzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-cGp4n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-fhheHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Tu7j5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6LtbZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-7U3Xqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-kdsd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-undOiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:35 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-EqYzcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:36 INFO - Running setup.py install for manifestparser 01:48:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:48:36 INFO - Running setup.py install for mozcrash 01:48:36 INFO - Running setup.py install for mozdebug 01:48:36 INFO - Running setup.py install for mozdevice 01:48:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:48:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:48:36 INFO - Running setup.py install for mozfile 01:48:36 INFO - Running setup.py install for mozhttpd 01:48:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:48:36 INFO - Running setup.py install for mozinfo 01:48:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Running setup.py install for mozInstall 01:48:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Running setup.py install for mozleak 01:48:37 INFO - Running setup.py install for mozlog 01:48:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Running setup.py install for moznetwork 01:48:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Running setup.py install for mozprocess 01:48:37 INFO - Running setup.py install for mozprofile 01:48:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:48:37 INFO - Running setup.py install for mozrunner 01:48:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:48:38 INFO - Running setup.py install for mozscreenshot 01:48:38 INFO - Running setup.py install for moztest 01:48:38 INFO - Running setup.py install for mozversion 01:48:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:38 INFO - Cleaning up... 01:48:38 INFO - Return code: 0 01:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:38 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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:38 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 01:48:38 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 01:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:38 INFO - 'HOME': '/Users/cltbld', 01:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:38 INFO - 'LOGNAME': 'cltbld', 01:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:38 INFO - 'MOZ_NO_REMOTE': '1', 01:48:38 INFO - 'NO_EM_RESTART': '1', 01:48:38 INFO - 'PAGER': '/bin/cat', 01:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:38 INFO - 'PWD': '/builds/slave/test', 01:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:38 INFO - 'SHELL': '/bin/bash', 01:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:38 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:38 INFO - 'USER': 'cltbld', 01:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:38 INFO - 'XPC_FLAGS': '0x0', 01:48:38 INFO - 'XPC_SERVICE_NAME': '0', 01:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:38 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Y4F4WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-fAepav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-ntWhUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-CRq2GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-CSEWjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-dTCWu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TINq9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-LgtGyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-iOMzAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-NjCPQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:39 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)) 01:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:39 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-AaJqqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-4C5zmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QscT6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QjOtuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-31d7zK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-7KMtui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:40 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)) 01:48:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:40 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-x0k2sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:40 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)) 01:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:48:40 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)) 01:48:40 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)) 01:48:40 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)) 01:48:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:43 INFO - Downloading blessings-1.6.tar.gz 01:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:43 INFO - Installing collected packages: blessings 01:48:43 INFO - Running setup.py install for blessings 01:48:43 INFO - Successfully installed blessings 01:48:43 INFO - Cleaning up... 01:48:44 INFO - Return code: 0 01:48:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:44 INFO - Reading from file tmpfile_stdout 01:48:44 INFO - Current package versions: 01:48:44 INFO - blessings == 1.6 01:48:44 INFO - blobuploader == 1.2.4 01:48:44 INFO - docopt == 0.6.1 01:48:44 INFO - manifestparser == 1.1 01:48:44 INFO - mozInstall == 1.12 01:48:44 INFO - mozcrash == 0.17 01:48:44 INFO - mozdebug == 0.1 01:48:44 INFO - mozdevice == 0.48 01:48:44 INFO - mozfile == 1.2 01:48:44 INFO - mozhttpd == 0.7 01:48:44 INFO - mozinfo == 0.9 01:48:44 INFO - mozleak == 0.1 01:48:44 INFO - mozlog == 3.1 01:48:44 INFO - moznetwork == 0.27 01:48:44 INFO - mozprocess == 0.22 01:48:44 INFO - mozprofile == 0.28 01:48:44 INFO - mozrunner == 6.11 01:48:44 INFO - mozscreenshot == 0.1 01:48:44 INFO - mozsystemmonitor == 0.0 01:48:44 INFO - moztest == 0.7 01:48:44 INFO - mozversion == 1.4 01:48:44 INFO - psutil == 3.1.1 01:48:44 INFO - requests == 1.2.3 01:48:44 INFO - wsgiref == 0.1.2 01:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:44 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 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:44 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 01:48:44 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 01:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:44 INFO - 'HOME': '/Users/cltbld', 01:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:44 INFO - 'LOGNAME': 'cltbld', 01:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:44 INFO - 'MOZ_NO_REMOTE': '1', 01:48:44 INFO - 'NO_EM_RESTART': '1', 01:48:44 INFO - 'PAGER': '/bin/cat', 01:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:44 INFO - 'PWD': '/builds/slave/test', 01:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:44 INFO - 'SHELL': '/bin/bash', 01:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:44 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:44 INFO - 'USER': 'cltbld', 01:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:44 INFO - 'XPC_FLAGS': '0x0', 01:48:44 INFO - 'XPC_SERVICE_NAME': '0', 01:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 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)) 01:48:44 INFO - Cleaning up... 01:48:44 INFO - Return code: 0 01:48:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48: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')]} 01:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48: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')]} 01:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:48:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:44 INFO - 'HOME': '/Users/cltbld', 01:48:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:44 INFO - 'LOGNAME': 'cltbld', 01:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:44 INFO - 'MOZ_NO_REMOTE': '1', 01:48:44 INFO - 'NO_EM_RESTART': '1', 01:48:44 INFO - 'PAGER': '/bin/cat', 01:48:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:44 INFO - 'PWD': '/builds/slave/test', 01:48:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:44 INFO - 'SHELL': '/bin/bash', 01:48:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:44 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:44 INFO - 'USER': 'cltbld', 01:48:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:44 INFO - 'XPC_FLAGS': '0x0', 01:48:44 INFO - 'XPC_SERVICE_NAME': '0', 01:48:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:44 INFO - Downloading/unpacking jsonschema 01:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:47 INFO - Downloading/unpacking functools32 (from jsonschema) 01:48:47 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 01:48:47 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 01:48:47 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 01:48:47 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 01:48:47 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 01:48:47 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 01:48:47 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:47 INFO - warning: no files found matching '*.txt' 01:48:47 INFO - no previously-included directories found matching 'build' 01:48:47 INFO - no previously-included directories found matching 'dist' 01:48:47 INFO - no previously-included directories found matching '.git*' 01:48:47 INFO - Installing collected packages: jsonschema, functools32 01:48:47 INFO - Running setup.py install for functools32 01:48:47 INFO - warning: no files found matching '*.txt' 01:48:47 INFO - no previously-included directories found matching 'build' 01:48:47 INFO - no previously-included directories found matching 'dist' 01:48:47 INFO - no previously-included directories found matching '.git*' 01:48:47 INFO - Successfully installed jsonschema functools32 01:48:47 INFO - Cleaning up... 01:48:48 INFO - Return code: 0 01:48:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab12a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab194c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb399dd46c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, '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.aDeqDdwgxt/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.iYM89sdrMD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 01:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:48 INFO - 'HOME': '/Users/cltbld', 01:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:48 INFO - 'LOGNAME': 'cltbld', 01:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:48 INFO - 'MOZ_NO_REMOTE': '1', 01:48:48 INFO - 'NO_EM_RESTART': '1', 01:48:48 INFO - 'PAGER': '/bin/cat', 01:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:48 INFO - 'PWD': '/builds/slave/test', 01:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:48 INFO - 'SHELL': '/bin/bash', 01:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:48:48 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:48 INFO - 'USER': 'cltbld', 01:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:48 INFO - 'XPC_FLAGS': '0x0', 01:48:48 INFO - 'XPC_SERVICE_NAME': '0', 01:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:48 INFO - Downloading/unpacking flake8 01:48:48 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 01:48:48 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 01:48:48 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 01:48:48 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 01:48:48 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 01:48:48 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 01:48:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:48:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:48:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:52 INFO - no previously-included directories found matching 'docs/_build' 01:48:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:48:52 INFO - Running setup.py install for pep8 01:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:48:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:48:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:48:52 INFO - no previously-included directories found matching 'docs/_build' 01:48:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:48:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:48:52 INFO - Cleaning up... 01:48:52 INFO - Return code: 0 01:48:52 INFO - Running post-action listener: _resource_record_post_action 01:48:52 INFO - Running post-action listener: _start_resource_monitoring 01:48:52 INFO - Starting resource monitoring. 01:48:52 INFO - ##### 01:48:52 INFO - ##### Running install step. 01:48:52 INFO - ##### 01:48:52 INFO - Running pre-action listener: _resource_record_pre_action 01:48:52 INFO - Running main action method: install 01:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:52 INFO - Reading from file tmpfile_stdout 01:48:52 INFO - Detecting whether we're running mozinstall >=1.0... 01:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:48:52 INFO - Reading from file tmpfile_stdout 01:48:52 INFO - Output received: 01:48:52 INFO - Usage: mozinstall [options] installer 01:48:52 INFO - Options: 01:48:52 INFO - -h, --help show this help message and exit 01:48:52 INFO - -d DEST, --destination=DEST 01:48:52 INFO - Directory to install application into. [default: 01:48:52 INFO - "/builds/slave/test"] 01:48:52 INFO - --app=APP Application being installed. [default: firefox] 01:48:52 INFO - mkdir: /builds/slave/test/build/application 01:48:52 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'] 01:48:52 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 01:49:26 INFO - Reading from file tmpfile_stdout 01:49:26 INFO - Output received: 01:49:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:49:26 INFO - Running post-action listener: _resource_record_post_action 01:49:26 INFO - ##### 01:49:26 INFO - ##### Running run-tests step. 01:49:26 INFO - ##### 01:49:26 INFO - Running pre-action listener: _resource_record_pre_action 01:49:26 INFO - Running main action method: run_tests 01:49:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:26 INFO - 2016-03-08 01:49:26.884 screenresolution[1640:7574] starting screenresolution argv=screenresolution get 01:49:26 INFO - 2016-03-08 01:49:26.887 screenresolution[1640:7574] Display 0: 1600x1200x32@60 01:49:26 INFO - 2016-03-08 01:49:26.893 screenresolution[1641:7576] starting screenresolution argv=screenresolution list 01:49:26 INFO - Available Modes on Display 0 01:49:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:27 INFO - Intel Iris: 01:49:27 INFO - Chipset Model: Intel Iris 01:49:27 INFO - Type: GPU 01:49:27 INFO - Bus: Built-In 01:49:27 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:27 INFO - Vendor: Intel (0x8086) 01:49:27 INFO - Device ID: 0x0a2e 01:49:27 INFO - Revision ID: 0x0009 01:49:27 INFO - Displays: 01:49:27 INFO - Display: 01:49:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:27 INFO - Display Serial Number: 1600x1200 60 01:49:27 INFO - Main Display: Yes 01:49:27 INFO - Mirror: Off 01:49:27 INFO - Online: Yes 01:49:27 INFO - Rotation: Supported 01:49:27 INFO - Return code: 0 01:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:27 INFO - Python 2.7.3 01:49:27 INFO - Return code: 0 01:49:27 INFO - grabbing minidump binary from tooltool 01:49: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')]} 01:49:27 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 0x10a9b6d30>, '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 0x10a81adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a9adb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:27 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 01:49:27 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 01:49:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:27 INFO - Return code: 0 01:49:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:49:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:49:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:49:28 INFO - Return code: 0 01:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 01:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 01:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.aDeqDdwgxt/Render', 01:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:28 INFO - 'HOME': '/Users/cltbld', 01:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:28 INFO - 'LOGNAME': 'cltbld', 01:49:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:49:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:28 INFO - 'MOZ_NO_REMOTE': '1', 01:49:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:49:28 INFO - 'NO_EM_RESTART': '1', 01:49:28 INFO - 'PAGER': '/bin/cat', 01:49:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:28 INFO - 'PWD': '/builds/slave/test', 01:49:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:28 INFO - 'SHELL': '/bin/bash', 01:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iYM89sdrMD/Listeners', 01:49:28 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 01:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:28 INFO - 'USER': 'cltbld', 01:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:28 INFO - 'XPC_FLAGS': '0x0', 01:49:28 INFO - 'XPC_SERVICE_NAME': '0', 01:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 01:49:28 INFO - mozversion application_buildid: 20160307110830 01:49:28 INFO - mozversion application_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:28 INFO - mozversion application_display_name: Nightly 01:49:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:28 INFO - mozversion application_name: Firefox 01:49:28 INFO - mozversion application_remotingname: firefox 01:49:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:28 INFO - mozversion application_vendor: Mozilla 01:49:28 INFO - mozversion application_version: 47.0a1 01:49:28 INFO - mozversion platform_buildid: 20160307110830 01:49:28 INFO - mozversion platform_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:28 INFO - mozversion platform_version: 47.0a1 01:49:28 INFO - using testdate: 1457430568 01:49:28 INFO - actual date: 1457430568 01:49:28 INFO - starting webserver on 'localhost:49270' 01:49:28 INFO - SUITE-START | Running 2 tests 01:49:28 INFO - TEST-START | dromaeo_css 01:49:28 INFO - operating with platform_type : mac_ 01:49:28 INFO - Initialising browser for dromaeo_css test... 01:49:28 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpztTpQC/profile http://localhost:49270/getInfo.html) 01:49:30 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 01:49:30 INFO - PROCESS | 1659 | colorDepth:24 01:49:30 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 01:49:30 INFO - PROCESS | 1659 | __metrics 01:49:31 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:49:31 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:49:31 INFO - TEST-INFO | 1659: exit 0 01:49:31 INFO - Browser initialized. 01:49:31 INFO - Running cycle 1/1 for dromaeo_css test... 01:49:31 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpztTpQC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:49:43 INFO - PROCESS | 1662 | RSS: Main: 243736576 01:49:43 INFO - PROCESS | 1662 | 01:50:34 INFO - PROCESS | 1662 | 1457430634299 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] 01:52:44 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 01:52:45 INFO - PROCESS | 1662 | RSS: Main: 383926272 01:52:45 INFO - PROCESS | 1662 | 01:55:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 01:55:49 INFO - PROCESS | 1662 | RSS: Main: 380354560 01:55:49 INFO - PROCESS | 1662 | 01:58:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 01:58:52 INFO - PROCESS | 1662 | RSS: Main: 378253312 01:58:52 INFO - PROCESS | 1662 | 02:01:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 02:01:54 INFO - PROCESS | 1662 | RSS: Main: 336302080 02:01:54 INFO - PROCESS | 1662 | 02:04:57 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 02:04:58 INFO - PROCESS | 1662 | RSS: Main: 336592896 02:04:58 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 02:08:01 INFO - PROCESS | 1662 | RSS: Main: 400125952 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | __start_tp_report 02:08:01 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 02:08:01 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 02:08:01 INFO - PROCESS | 1662 | |i|pagename|runs| 02:08:01 INFO - PROCESS | 1662 | |0;dojo.html;2976.8809247630084;3469.531613232213;3500.579930408351;3522.1370764162784;3547.130952916536;5592.133219351007;5601.8039368622;5615.634983726055;5616.971915140423;5631.239782629349;5579.079451890433;5661.60368774186;5698.51562617178;5702.77188912444;5729.799457019005;5060.266261392096;5081.212412076125;5118.539331460168;5130.179171332587;5208.791648334062;5181.4300426953005;5199.792008319662;5242.266082748418;5258.395284542269;5291.365036195662;5054.949450505503;5081.542661160476;5150.278960945452;5162.845114646567;5190.532852043334;5114.718690472023;5133.255677926717;5136.357955255593;5148.227765835118;5153.587712982952;5095.3376061112185;5129.9230511542355;5140.1518749406305;5147.176451767699;5173.249878767558;5486.451354864522;5585.078462053756;5612.550995920316;5696.458836410535;5700.230468886689;6176.197094377702;6186.4741496972365;6188.504919606421;6202.875942481125;6215.098810672427;6203.348648391944;6264.3422440643535;6266.060090986343;6268.028455589391;6268.247810262752;5624.268845050117;5727.570432217601;5744.798932037401;5846.239988801429;5847.532197424196;6249.281332646804;6268.561200715906;6269.592476489013;6273.65494897785;6278.340774218641;5872.530197584183;6033.42682445167;6153.538484613582;6155.199824022938;6163.630182189083;6134.478569321657;6149.524114212646;6175.938240617626;6254.968725156436;6264.467520260738;6165.876682466325;6170.691465426711;6178.969105154445;6181;6191.040388739752;6179.16581261533;6201.255849298022;6205.782797602063;6217.720202590895;6222.968885155636;4703.45910220329;4766.594839438617;4811.615070794328;4825.227963525819;4930.2851086592245;4393.802278897458;4418.293073108287;4422.226110430662;4456.197884380777;4458.71018383804;5677.51741102011;5678.5741069419955;5688.203651488795;5694.544436445074;5698.202251684685;6155.984262596711;6175.938240617626;6176.876462470816;6266.248050234001;6294.622322660655;5724.398938111438;5743.1385292206505;5744.0522313817755;5747.712614369265;5771.653700777967;4584;5359.866003349869;5372.435894231049;5390.487903649226;5394.973025134849;6191.318954914956;6298.212723409574;6377.71300291488;6409.55133140685;6425.068365087036;6227.501799856092;6250.968745156245;6257.530685198537;6273.560850740587;6284.748610055546;6159.815205543661;6356.872862542631;6357.682115894279;6360.840978975562;6373;6111.682900513496;6115.082737589397;6141.087915201912;6202;6241.625502469867;6263.342349053284;6276.246850377984;6290.150829637941;6290.811275661737;6299.779507717208;5874.324452687824;5982.760689572368;6125.785597504066;6153.938460615336;6154.723037463235;5966.701664916824;5978;6008.699565021644;6011.879762404815;6022.668753218615;4790.784414701417;4792.472827988988;5880.382559831327;5934.43622855828;5957.463828255478;6112.205413296243;6114.419130182626;6123.608384081089;6124.479419249414;6141;5030.220315851049;5811.94188058114;5904.996150654313;5938.109283607493;5946.583739138218 02:08:01 INFO - PROCESS | 1662 | |1;ext.html;486.48918635432784;562.8986782379176;569.1377562992067;571.1318795430946;607.3835057416723;26562.07032753854;38390.232195356075;38438;38460.03849903754;38534.036649083784;42468.362974555406;42724.57275427253;42814.57185428145;42871.78564107183;43034;7234.710611575544;9727.951360243223;9734.318597698164;9740.610375584969;9756.170725488342;9538.713838584854;9641.084097010773;9716.417014979088;9736.513174341255;9841.852372214422;9805.901940980606;9901.257405694565;9902.455364954925;9904.950475247613;9911.306208565404;9784.90215097847;9864.210863131004;9864.654737084167;9868.161206297473;9886.505674716236;9544.665936692183;9667.70996870095;9675.758106047335;9685.32202745808;9716.514174291256;41403.7929810352;41805.1638967219;41879.790601047105;41900.161996759896;41918.58081419177;3492.6681965213265;3679.742418030739;3853.133045064866;3910.5893881142356;4208.548050922427;28954.855225723735;29284.560731589045;29357.70642293571;29407.97072102466;29907.700922990927;2654.4292977010036;2666.4933662604235;2692.17888543994;2752.6146339512284;2793.5809628555676;490467;490515;491811.54094229656;492503.53748231387;492741;46568.30147547789;67565.32434675591;68663.31336686669;69664.30335696679;69690.3030969694;45991;46234.76882615632;46301;46312.30531542029;46347.07305853864;16088.919555402148;16285.674286514204;16306.103164326076;16306.836931630532;16345.182740862909;13028.739425211632;13051.608451746462;13060.934695326652;13087.149335293176;13088.08383413171;15108;15117.319720612599;15126.773098403533;15166.772498412533;15267.541973740805;6354.904676429857;6457.709403076873;6484.221893372825;6489.8702025960165;6501.577397469149;952.4333021851987;960.9807803843884;979.7991411760572;980.9411435313762;1086.766345235778;29671.109866704035;30084;30157.246068848017;30234.697653023628;30539.541906871415;1093.0763504838399;1117.6032508459543;1128.7516746315798;1203.7764756210238;1243.2354102227246;15095.32071056805;15153.924230378778;15167.393304267927;15618.062916225063;15645.530634080997;520683;973098;984116;985468;986229;62286;62642.68678656578;63211.367886321466;63361.36638633647;63565;1335.79963005548;1355.491690616019;1438.496526215837;1462.444271176946;1482.0811097119854;26325.605115922892;30953.226169345045;31029.0691279262;31736.04791856248;31893.68106319;55210.723946380014;55335;56119.877602446904;56125;56129.43870561242;404742;407384;407931;408066;409084;29066.56400153957;32753.34493310168;33000.01999880015;33474.163145920575;34075.97772066842;35171;42207.577924220364;42496.15007699767;42838.57161428346;43767.78116109399;34536.82731586326;35705;36029.45955810612;36578.634213657526;36596.63403365932;27541.44917101687;35216.11959701028;35578.644213557534;35847.82076089603;36117.27765444729;35690;36063.63936360708;36326.636733632324;36539.08652283714;36792.81603591965;28974.27564310909;31646.841765791025;32694.509582355808;32826;32836.83581582077;23028.884855575616;24290.75709242885;24460;24610.89250983746;24790.628140578265 02:08:01 INFO - PROCESS | 1662 | |2;jquery.html;312.5062401405779;358.7632162772569;366.5711117991949;366.88443140410766;370.8460988689691;20574.971251437444;20905.163793448264;21367.35897923061;21397.893010534925;21420.144374012652;19930.501737456572;20468.488287792814;20748.377548673565;20755;20774.792252077474;4284.807183676734;5265.526102650761;5306.8407947761625;5310.62825602208;5319.521243088121;3352.513885486603;3883.864064757734;4456.532064133268;5139.280500729901;6398.71205795738;5650.858728531799;6356.364363563653;6358.427741503264;6364.777232796853;6365.077063825743;5703.62926409782;5826.271716035496;5828.271466066699;6331.55679102463;6342.365763423667;5533.557315414757;5567.3040869891265;5579.860503487445;5584.664920104807;5607.80372686954;13577.728445431036;13665.701758332942;13889.652758681113;13921.23433211173;13935.930320348434;2172.598069357174;2392.318189316054;2475.26979541034;2771.722827717212;2778.2498725344244;9416.340856140074;9752.804943901083;10133.03736145065;12479.108082506415;14785.926070369687;1711.093120646047;1718.269735362466;1753.2723919573361;1799.0824679413463;1802.9008404537744;84228.57885710594;107245;111505.88494115036;114500;118138.8186118145;10744.785104297871;11300.208985370946;11313.490892909838;11354.432278386048;11479.311241325548;13511.459541618422;13568.93215533916;13609.251491167883;13622.978276629094;13659.112157709716;8581.828363432696;8640.956795216109;8652.956735216283;8688.869666955;8765.912340876637;9004.8649270261;9031.81936361269;9042.502662353634;9051.95902471211;9142.451452912846;4518.615917647036;4569.588737013684;4586.931196032062;4590.357349971006;4613.123506533815;1831.9908400457912;1891.3569386408687;1905.4569447707613;1910.2550005497867;1943.5626983928785;777.5140537164273;826.1738261738262;874.8906386701663;931.888173419194;935.9766005849772;20275.986200689906;20578.588428231353;21320.933953302272;21405.78594214069;21507.354779356643;812.7764864662147;920.3649481857497;925.847235206197;934.1965909317981;992.2607657295362;11138.443077846076;11468.254563453349;11476.196666233283;11502.654920352403;11503.367314797766;557909.4209057939;590599;590866;609680;624501;117732;120076;120393;130262;138605;1000.314784372707;1025.4411345816548;1046.5447530324334;1047.3401756893109;1049.5591851422573;18840.811591883907;18849.057547122862;18876;19189.520261993002;19197;51383.74308128585;51603;53099;54419.72790136024;55051.44948550463;60830.78338433295;77087;78393.43213135819;78410.21589784029;78512.60743696245;7882.330001949669;8012.599370031592;8029.799255018671;8185.058718247477;8202.507849529047;11713.1800773945;13084.476620935056;13158.868411316147;13404.32978351059;13507.39216735269;10724.356538607708;10895.96488333607;11040.558377665126;11146.777064458827;11515.136364772508;10998.670039898816;11164.553417863519;11270.830937536108;11434.371109589052;11508.194426390408;10890.564377424815;11070.778584428428;11339;11676.649700508999;11753.236039657395;7956.920430795618;8016.198380161937;8123.3501319893085;8137.877931831145;8324.791880202802;8169.918300816916;9578.664746733832;10748.516316765921;10753.1935104869;10899.618513351994 02:08:01 INFO - PROCESS | 1662 | |3;mootools.html;1464.0264224290847;1622.5943514121466;1723.6380360124374;1967.2917749610137;2044.5093177637361;8120.593970301484;8571.571421428927;8727.389082764217;8754.737357879274;8778;8477.703280385187;8759.781005474866;8766.904136982877;8773.210411063003;8804.075572064938;2184.803367696907;2247.763984781599;2252.279270633398;2460.4341001569605;2490.5641512735288;2463.027104293812;2527.721950585434;2532.202356257773;2535.21408363407;2539;2431.817613678981;2473.6042233242683;2480.937976550583;2490.3276115448816;2496.8002559795264;2434.610462326037;2471.9134830280946;2473.492933948536;2486.1422809131;2504.0734928076545;2475.517274131545;2488.203774792067;2488.5271798358253;2495.8752062396807;2502.5620516409554;8907.910920890772;8955.462672239686;8963.775905602346;8966.68616598416;8983.640654373818;5385.919211211835;5601.103823388238;5606.467385598403;5609.382967873531;5620.690862002588;3551.7691350062423;3640.4903313536124;3683.4290684943876;3699.648533389324;3717.739758216926;1017.867677201959;1022.5143057047843;1022.6931920423917;1035.59094157808;1040.505759764106;10029.548670309854;12183.695407614792;12197.390130493528;12198.024158067334;12208.450619722134;4846.927296090562;4896.706197628154;5000.824971126066;5009.7495125243595;5016.623753218523;10096.444695541815;10285.691429257135;10303.639372621923;10307.330023548446;10322.071013608662;4743.146233677902;5556.861078473071;5563.860903477445;5570.61005729595;5576.832695019156;4491.371208030879;4624.606908412823;4832.613390928717;5051.06555287273;5068.265101560327;3916.80537436079;3925.0776067624083;3957.8021098944937;4045.554988951213;4047.817848196838;1138.2658185470325;1303.5307289375817;1318.698870471015;1329.8404191497082;1329.9202047877159;1360.7550640884538;1367.2958426410407;1398.8880889528814;1416.6458385403444;1423.0963338280267;8091.676332946734;8251.257386835094;8269.62786674601;8276.50340979531;8300.294474969574;506.5846006274819;509.1090591464936;518.0623072239259;518.2537146509015;530.3821048478557;6238.625682459067;6243.43809057187;6339.0808332791485;6351.047342898602;6384.936150638434;10453.216008799218;10829.83755243672;10914.945425272823;10929.781404371868;10949.890501095046;10307.639232626972;10730.678079657622;10759.83860242097;10789;10813;8303.833923321621;8316.916830831735;8327.916720832834;8363.83272334562;8422.915770842335;6517.8696426072165;7684.961575192088;7800.6099695016155;7833.882491762514;7944.285014348737;9388;9687.70936871895;9689.806203875742;9793.85309220348;9810.460424676712;9770.31607787448;9974.700758977242;9987.950060249652;10109.595616175271;10118.392896426238;6869.965650171917;7212;7446.515976461513;7586.62066896664;7667.348275396431;8263.793405164679;8297.95851020741;8302.54336011525;8304.70933517324;8317;7244;7394.704211831467;7421.554706717614;7488.9625551871895;7563.848723025619;7267.345938865316;7308.524945878501;7318.377937875341;7323.816904577215;7464;7705.42209334291;7720.034995625547;7774.378049756119;7784.844303113793;7796.337311328373;6956.826079348057;6979.441644668313;6997.545159564612;7044.6125463100025;7045.682944267418;7077.5753454792875;7086;7140.357367836919;7143;7158.928410716035 02:08:01 INFO - PROCESS | 1662 | |4;prototype.html;321.84068885901473;327.1575692591576;329.2673800793234;332.39338207770817;332.83524655295616;6115.480184184338;6526.347365263471;6589.374009469105;6598.5710928789595;6611.4049735523795;5734.971325143379;6492.935070649292;6518.543701940866;6524.836879078025;6526.282108968022;4619.399478067863;4724.503927087658;4747.026859493795;4766.928496072562;4837.903241935159;4671.766411679402;4763.047390521892;4766.6901651392545;4780.737059461728;4805.303231031498;4672.97663511682;4690.671652984292;4712.646551508634;4719.315699223627;4725.763711814413;4520.141173177086;4713.2427529894885;4757.452892917324;4767.809287628491;4785.641076919228;3272.345530893831;4055.7363771354767;4057.1479989202007;4060.8375664973364;4076.1643863008308;6194.442500175006;6249.9062514062325;6272.247330320345;6274.937250627481;6287.402696743802;5628.634138781007;5635.5773317001385;5645.181448689958;5648.068068768648;5668.489835914787;6940.757073502403;6960.721571137148;6966.477514186406;6997.370236678673;7001.614911179883;3801.657850793442;4313.15893400787;4609.861704148881;4612.607928326096;4622.930656040162;7288.489805713549;7434.9256507434775;7450.590217538033;7486.737964171282;7517.699292028367;4596.057808149321;4596.241620132708;4598.839040633628;4599.149157405891;4599.9080018399445;4661.790219440133;4677.532246775295;4683.953160468352;4684.882877928079;4688.742119183409;5577.27495425592;5577.358603760538;5589.301337332833;5589.74846131925;5591.245181900473;5061;5878.911816322759;6775.593464392152;7026.754063607749;7108.182559005677;1595.4894433781078;1609.0265389439455;1622.691688579166;1624.8618867396167;1626.463267121847;1025.738436698637;1027.5170669785189;1042.3537406807827;1048.580567772897;1052.2423854824515;6377.489800815923;6535.215774107042;6559.737610495622;6625.768098116543;6744.831379215559;7429.4799364044;7439.590822504706;7446.627668616547;7449.962750186214;7451.813704657427;6708.362705543063;6711.6979735912;6712;6715.227748808852;6715.966420167965;3861.131245469747;3895.0846551060476;3909;3911.6675082618294;3912.1002169501176;6644.803935291694;7518.473706840468;7786.065672119382;7798.727044553527;7822.1786712395515;6146.416090471398;7376.520526165782;7575.431842611826;7620.733274335372;7634.6182690865235;7732.4200684948855;7755.612219388895;7758.728444504415;7759.301662850257;7763.0684317882215;5962.850928726816;7355.8161045974275;7381.261873812576;7383.852322953619;7396.704131834882;5809.331926828469;6950.617716025465;7192.604406757679;7225.494215404871;7232.74685386009;7676.654550545127;7737;7737.3036426721865;7747.883781743391;7751.457397982087;4577.382053422745;4641.071785642953;4641.071785642953;4647.419072615923;4649.651276154234;7295.4528410368375;7312.232215617496;7329.157146928172;7332.926670733438;7344.96327518359;6819.318068193141;7085.078939737801;7109.324614161646;7138.928610713826;7147.392471639969;5749.712514374348;6688.5619591788;7077.292270772881;7082.681279342545;7107.182673992557;5618.803341883178;6040.275166979991;6145.388210010817;6744.325567443217;6917.861642767217;6809.897851532132;7099.609521476162;7102.18324892644;7128.714851406093;7144.892826607709;6646.302138275411;6786.253512113565;6859.7256109757045;6939.757108501179;6978.546394484342 02:08:01 INFO - PROCESS | 1662 | |5;yui.html;679.1307126877597;700.4851434195865;739.2533541123464;772.2740623813614;799.8880156778049;12384.504619815209;15288;15323.770143447857;15329.386824527006;15350.923245383772;13798.586042418743;13940.581782546515;13996.510122145726;14013.579592612212;14013.789793153112;751.9849603007937;759.1876691939627;909.9317551183672;932.1703683721494;935.9391639543442;754.3625636337314;906.7098528470859;930.6882194464862;935.046252822121;935.9844568643031;976.4239098931629;984.3847595252967;985.2167526816163;985.231519414854;991.3358050106445;781.8944442500247;978.8580655804903;979.314479864098;979.8432250839867;980.5734505490099;719.5574721546211;729.8467321862415;730.612775229124;731.3417923868508;732.1214542548962;15002.324895379734;15012.924935375362;15060.849391506164;15073;15094.849051509455;12272.32502212378;12341.382930853422;12551.372431378395;12578.61635220125;12668.68328291791;9797.608095676236;9905.35615185018;10057.195424366033;10130.341527800743;10300.330478518872;3469.5836499619954;3557.217412169319;3618.8914332570066;3624.4958342288182;3660.2313514162056;80835;81182.59408702978;81777.59111204406;83945;84502.57748711217;9564.808703825884;9566.234701223886;9661.46861922601;9906.306558540977;10008.699739007841;22035.66946495804;22044.11823527041;22062;22077.558448830932;22090.33728988133;7299.19708832028;7432.2567743225245;7436.107667079877;7436.479446438698;7490.02629658141;3996.8800935971385;4000.5199376074474;4009.278329900588;4016.8393264269102;4069.9389509157386;3628.5101511296166;3668.3763760160837;3686.705063594906;3690.0774806298427;3692.704583633357;653.702565332782;657.454312920275;674.1640365946191;683.8153698501377;691.1326285511751;513.5249893848176;555.7221389305347;589.9705014749245;594.4204400709274;598.6886818854172;7928.7621371358955;7950.761477155695;8009.679612815422;8117.350611951029;8189.1401402853035;541.5965105996058;542.2435702195415;585.0668184246206;600.4431606853174;600.5285850607339;3705.7085392198355;3726.8509259629855;3776.905577360588;3834.559025712079;3862.4978752761963;92504;93635.06364936399;94706;94761;94961;79304.20695793083;79859;80596.59701701571;80962;81515;70961.64519177475;72166;72218;72619;73550;7287.489875708649;7417.8887316689215;7440.404767618686;7543.660535276035;7743.380529557735;47419.525804742894;47430.76284618555;47613;48230.553083407554;48869.556522173036;58233.70883145557;62207;68868;69291;70439;10206.285560010729;10263.435511046964;10361.63734269297;10433.530491127765;10808.243422960317;10816.783664326827;10846.403447810131;11108.666739997812;11260.887391125983;11482.081433485135;9895.950520247641;10133.543990520297;10249.12882405004;10468.738281543023;10476.895231047592;10076.94961525217;10312.948435257777;10319.432431216355;11583.131265155316;12324.876751232732;11339.969677625306;11358.602448914578;11474.368909710047;11642;11847.466863991314;9426.528673566432;9532.904670953201;9813.313068085166;9878.851817222603;10044.899551004688;9392;9594.18449431806;9758.85361719589;9785.266105042008;9835.70492885186 02:08:01 INFO - PROCESS | 1662 | __end_tp_report 02:08:01 INFO - PROCESS | 1662 | __start_cc_report 02:08:01 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1270 02:08:01 INFO - PROCESS | 1662 | __end_cc_report 02:08:01 INFO - PROCESS | 1662 | __startTimestamp1457431681363__endTimestamp 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | ------- Summary: start ------- 02:08:01 INFO - PROCESS | 1662 | Number of tests: 6 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5698.16 Median:5905.00 stddev:658.67 (11.2%) stddev-sans-first:625.14 02:08:01 INFO - PROCESS | 1662 | Values: 2976.9 3469.5 3500.6 3522.1 3547.1 5592.1 5601.8 5615.6 5617.0 5631.2 5579.1 5661.6 5698.5 5702.8 5729.8 5060.3 5081.2 5118.5 5130.2 5208.8 5181.4 5199.8 5242.3 5258.4 5291.4 5054.9 5081.5 5150.3 5162.8 5190.5 5114.7 5133.3 5136.4 5148.2 5153.6 5095.3 5129.9 5140.2 5147.2 5173.2 5486.5 5585.1 5612.6 5696.5 5700.2 6176.2 6186.5 6188.5 6202.9 6215.1 6203.3 6264.3 6266.1 6268.0 6268.2 5624.3 5727.6 5744.8 5846.2 5847.5 6249.3 6268.6 6269.6 6273.7 6278.3 5872.5 6033.4 6153.5 6155.2 6163.6 6134.5 6149.5 6175.9 6255.0 6264.5 6165.9 6170.7 6179.0 6181.0 6191.0 6179.2 6201.3 6205.8 6217.7 6223.0 4703.5 4766.6 4811.6 4825.2 4930.3 4393.8 4418.3 4422.2 4456.2 4458.7 5677.5 5678.6 5688.2 5694.5 5698.2 6156.0 6175.9 6176.9 6266.2 6294.6 5724.4 5743.1 5744.1 5747.7 5771.7 4584.0 5359.9 5372.4 5390.5 5395.0 6191.3 6298.2 6377.7 6409.6 6425.1 6227.5 6251.0 6257.5 6273.6 6284.7 6159.8 6356.9 6357.7 6360.8 6373.0 6111.7 6115.1 6141.1 6202.0 6241.6 6263.3 6276.2 6290.2 6290.8 6299.8 5874.3 5982.8 6125.8 6153.9 6154.7 5966.7 5978.0 6008.7 6011.9 6022.7 4790.8 4792.5 5880.4 5934.4 5957.5 6112.2 6114.4 6123.6 6124.5 6141.0 5030.2 5811.9 5905.0 5938.1 5946.6 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:71952.53 Median:204326.29 stddev:173528.33 (84.9%) stddev-sans-first:173932.16 02:08:01 INFO - PROCESS | 1662 | Values: 486.5 562.9 569.1 571.1 607.4 26562.1 38390.2 38438.0 38460.0 38534.0 42468.4 42724.6 42814.6 42871.8 43034.0 7234.7 9728.0 9734.3 9740.6 9756.2 9538.7 9641.1 9716.4 9736.5 9841.9 9805.9 9901.3 9902.5 9905.0 9911.3 9784.9 9864.2 9864.7 9868.2 9886.5 9544.7 9667.7 9675.8 9685.3 9716.5 41403.8 41805.2 41879.8 41900.2 41918.6 3492.7 3679.7 3853.1 3910.6 4208.5 28954.9 29284.6 29357.7 29408.0 29907.7 2654.4 2666.5 2692.2 2752.6 2793.6 490467.0 490515.0 491811.5 492503.5 492741.0 46568.3 67565.3 68663.3 69664.3 69690.3 45991.0 46234.8 46301.0 46312.3 46347.1 16088.9 16285.7 16306.1 16306.8 16345.2 13028.7 13051.6 13060.9 13087.1 13088.1 15108.0 15117.3 15126.8 15166.8 15267.5 6354.9 6457.7 6484.2 6489.9 6501.6 952.4 961.0 979.8 980.9 1086.8 29671.1 30084.0 30157.2 30234.7 30539.5 1093.1 1117.6 1128.8 1203.8 1243.2 15095.3 15153.9 15167.4 15618.1 15645.5 520683.0 973098.0 984116.0 985468.0 986229.0 62286.0 62642.7 63211.4 63361.4 63565.0 1335.8 1355.5 1438.5 1462.4 1482.1 26325.6 30953.2 31029.1 31736.0 31893.7 55210.7 55335.0 56119.9 56125.0 56129.4 404742.0 407384.0 407931.0 408066.0 409084.0 29066.6 32753.3 33000.0 33474.2 34076.0 35171.0 42207.6 42496.2 42838.6 43767.8 34536.8 35705.0 36029.5 36578.6 36596.6 27541.4 35216.1 35578.6 35847.8 36117.3 35690.0 36063.6 36326.6 36539.1 36792.8 28974.3 31646.8 32694.5 32826.0 32836.8 23028.9 24290.8 24460.0 24610.9 24790.6 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:34169.34 Median:2282.46 stddev:99097.33 (4341.7%) stddev-sans-first:99342.72 02:08:01 INFO - PROCESS | 1662 | Values: 312.5 358.8 366.6 366.9 370.8 20575.0 20905.2 21367.4 21397.9 21420.1 19930.5 20468.5 20748.4 20755.0 20774.8 4284.8 5265.5 5306.8 5310.6 5319.5 3352.5 3883.9 4456.5 5139.3 6398.7 5650.9 6356.4 6358.4 6364.8 6365.1 5703.6 5826.3 5828.3 6331.6 6342.4 5533.6 5567.3 5579.9 5584.7 5607.8 13577.7 13665.7 13889.7 13921.2 13935.9 2172.6 2392.3 2475.3 2771.7 2778.2 9416.3 9752.8 10133.0 12479.1 14785.9 1711.1 1718.3 1753.3 1799.1 1802.9 84228.6 107245.0 111505.9 114500.0 118138.8 10744.8 11300.2 11313.5 11354.4 11479.3 13511.5 13568.9 13609.3 13623.0 13659.1 8581.8 8641.0 8653.0 8688.9 8765.9 9004.9 9031.8 9042.5 9052.0 9142.5 4518.6 4569.6 4586.9 4590.4 4613.1 1832.0 1891.4 1905.5 1910.3 1943.6 777.5 826.2 874.9 931.9 936.0 20276.0 20578.6 21320.9 21405.8 21507.4 812.8 920.4 925.8 934.2 992.3 11138.4 11468.3 11476.2 11502.7 11503.4 557909.4 590599.0 590866.0 609680.0 624501.0 117732.0 120076.0 120393.0 130262.0 138605.0 1000.3 1025.4 1046.5 1047.3 1049.6 18840.8 18849.1 18876.0 19189.5 19197.0 51383.7 51603.0 53099.0 54419.7 55051.4 60830.8 77087.0 78393.4 78410.2 78512.6 7882.3 8012.6 8029.8 8185.1 8202.5 11713.2 13084.5 13158.9 13404.3 13507.4 10724.4 10896.0 11040.6 11146.8 11515.1 10998.7 11164.6 11270.8 11434.4 11508.2 10890.6 11070.8 11339.0 11676.6 11753.2 7956.9 8016.2 8123.4 8137.9 8324.8 8169.9 9578.7 10748.5 10753.2 10899.6 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:6078.93 Median:518.16 stddev:3219.22 (621.3%) stddev-sans-first:3209.56 02:08:01 INFO - PROCESS | 1662 | Values: 1464.0 1622.6 1723.6 1967.3 2044.5 8120.6 8571.6 8727.4 8754.7 8778.0 8477.7 8759.8 8766.9 8773.2 8804.1 2184.8 2247.8 2252.3 2460.4 2490.6 2463.0 2527.7 2532.2 2535.2 2539.0 2431.8 2473.6 2480.9 2490.3 2496.8 2434.6 2471.9 2473.5 2486.1 2504.1 2475.5 2488.2 2488.5 2495.9 2502.6 8907.9 8955.5 8963.8 8966.7 8983.6 5385.9 5601.1 5606.5 5609.4 5620.7 3551.8 3640.5 3683.4 3699.6 3717.7 1017.9 1022.5 1022.7 1035.6 1040.5 10029.5 12183.7 12197.4 12198.0 12208.5 4846.9 4896.7 5000.8 5009.7 5016.6 10096.4 10285.7 10303.6 10307.3 10322.1 4743.1 5556.9 5563.9 5570.6 5576.8 4491.4 4624.6 4832.6 5051.1 5068.3 3916.8 3925.1 3957.8 4045.6 4047.8 1138.3 1303.5 1318.7 1329.8 1329.9 1360.8 1367.3 1398.9 1416.6 1423.1 8091.7 8251.3 8269.6 8276.5 8300.3 506.6 509.1 518.1 518.3 530.4 6238.6 6243.4 6339.1 6351.0 6384.9 10453.2 10829.8 10914.9 10929.8 10949.9 10307.6 10730.7 10759.8 10789.0 10813.0 8303.8 8316.9 8327.9 8363.8 8422.9 6517.9 7685.0 7800.6 7833.9 7944.3 9388.0 9687.7 9689.8 9793.9 9810.5 9770.3 9974.7 9988.0 10109.6 10118.4 6870.0 7212.0 7446.5 7586.6 7667.3 8263.8 8298.0 8302.5 8304.7 8317.0 7244.0 7394.7 7421.6 7489.0 7563.8 7267.3 7308.5 7318.4 7323.8 7464.0 7705.4 7720.0 7774.4 7784.8 7796.3 6956.8 6979.4 6997.5 7044.6 7045.7 7077.6 7086.0 7140.4 7143.0 7158.9 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:5705.49 Median:6332.45 stddev:1854.30 (29.3%) stddev-sans-first:1814.94 02:08:01 INFO - PROCESS | 1662 | Values: 321.8 327.2 329.3 332.4 332.8 6115.5 6526.3 6589.4 6598.6 6611.4 5735.0 6492.9 6518.5 6524.8 6526.3 4619.4 4724.5 4747.0 4766.9 4837.9 4671.8 4763.0 4766.7 4780.7 4805.3 4673.0 4690.7 4712.6 4719.3 4725.8 4520.1 4713.2 4757.5 4767.8 4785.6 3272.3 4055.7 4057.1 4060.8 4076.2 6194.4 6249.9 6272.2 6274.9 6287.4 5628.6 5635.6 5645.2 5648.1 5668.5 6940.8 6960.7 6966.5 6997.4 7001.6 3801.7 4313.2 4609.9 4612.6 4622.9 7288.5 7434.9 7450.6 7486.7 7517.7 4596.1 4596.2 4598.8 4599.1 4599.9 4661.8 4677.5 4684.0 4684.9 4688.7 5577.3 5577.4 5589.3 5589.7 5591.2 5061.0 5878.9 6775.6 7026.8 7108.2 1595.5 1609.0 1622.7 1624.9 1626.5 1025.7 1027.5 1042.4 1048.6 1052.2 6377.5 6535.2 6559.7 6625.8 6744.8 7429.5 7439.6 7446.6 7450.0 7451.8 6708.4 6711.7 6712.0 6715.2 6716.0 3861.1 3895.1 3909.0 3911.7 3912.1 6644.8 7518.5 7786.1 7798.7 7822.2 6146.4 7376.5 7575.4 7620.7 7634.6 7732.4 7755.6 7758.7 7759.3 7763.1 5962.9 7355.8 7381.3 7383.9 7396.7 5809.3 6950.6 7192.6 7225.5 7232.7 7676.7 7737.0 7737.3 7747.9 7751.5 4577.4 4641.1 4641.1 4647.4 4649.7 7295.5 7312.2 7329.2 7332.9 7345.0 6819.3 7085.1 7109.3 7138.9 7147.4 5749.7 6688.6 7077.3 7082.7 7107.2 5618.8 6040.3 6145.4 6744.3 6917.9 6809.9 7099.6 7102.2 7128.7 7144.9 6646.3 6786.3 6859.7 6939.8 6978.5 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:18324.63 Median:31430.35 stddev:26114.44 (83.1%) stddev-sans-first:26154.09 02:08:01 INFO - PROCESS | 1662 | Values: 679.1 700.5 739.3 772.3 799.9 12384.5 15288.0 15323.8 15329.4 15350.9 13798.6 13940.6 13996.5 14013.6 14013.8 752.0 759.2 909.9 932.2 935.9 754.4 906.7 930.7 935.0 936.0 976.4 984.4 985.2 985.2 991.3 781.9 978.9 979.3 979.8 980.6 719.6 729.8 730.6 731.3 732.1 15002.3 15012.9 15060.8 15073.0 15094.8 12272.3 12341.4 12551.4 12578.6 12668.7 9797.6 9905.4 10057.2 10130.3 10300.3 3469.6 3557.2 3618.9 3624.5 3660.2 80835.0 81182.6 81777.6 83945.0 84502.6 9564.8 9566.2 9661.5 9906.3 10008.7 22035.7 22044.1 22062.0 22077.6 22090.3 7299.2 7432.3 7436.1 7436.5 7490.0 3996.9 4000.5 4009.3 4016.8 4069.9 3628.5 3668.4 3686.7 3690.1 3692.7 653.7 657.5 674.2 683.8 691.1 513.5 555.7 590.0 594.4 598.7 7928.8 7950.8 8009.7 8117.4 8189.1 541.6 542.2 585.1 600.4 600.5 3705.7 3726.9 3776.9 3834.6 3862.5 92504.0 93635.1 94706.0 94761.0 94961.0 79304.2 79859.0 80596.6 80962.0 81515.0 70961.6 72166.0 72218.0 72619.0 73550.0 7287.5 7417.9 7440.4 7543.7 7743.4 47419.5 47430.8 47613.0 48230.6 48869.6 58233.7 62207.0 68868.0 69291.0 70439.0 10206.3 10263.4 10361.6 10433.5 10808.2 10816.8 10846.4 11108.7 11260.9 11482.1 9896.0 10133.5 10249.1 10468.7 10476.9 10076.9 10312.9 10319.4 11583.1 12324.9 11340.0 11358.6 11474.4 11642.0 11847.5 9426.5 9532.9 9813.3 9878.9 10044.9 9392.0 9594.2 9758.9 9785.3 9835.7 02:08:01 INFO - PROCESS | 1662 | -------- Summary: end -------- 02:08:01 INFO - PROCESS | 1662 | 02:08:01 INFO - TEST-INFO | 1662: exit 0 02:08:01 INFO - TEST-OK | dromaeo_css | took 1113271ms 02:08:01 INFO - TEST-START | kraken 02:08:01 INFO - operating with platform_type : mac_ 02:08:01 INFO - Initialising browser for kraken test... 02:08:01 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp9MvKDo/profile http://localhost:49270/getInfo.html) 02:08:04 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 02:08:04 INFO - PROCESS | 1673 | colorDepth:24 02:08:04 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 02:08:04 INFO - PROCESS | 1673 | __metrics 02:08:04 INFO - PROCESS | 1673 | 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" 02:08:04 INFO - PROCESS | 1673 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:08:04 INFO - TEST-INFO | 1673: exit 0 02:08:04 INFO - Browser initialized. 02:08:04 INFO - Running cycle 1/1 for kraken test... 02:08:04 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmp9MvKDo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:16 INFO - PROCESS | 1675 | RSS: Main: 242974720 02:08:16 INFO - PROCESS | 1675 | 02:08:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:19 INFO - PROCESS | 1675 | RSS: Main: 289923072 02:08:19 INFO - PROCESS | 1675 | 02:08:22 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 02:08:23 INFO - PROCESS | 1675 | RSS: Main: 299675648 02:08:23 INFO - PROCESS | 1675 | 02:08:26 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 02:08:27 INFO - PROCESS | 1675 | RSS: Main: 285306880 02:08:27 INFO - PROCESS | 1675 | 02:08:29 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 02:08:29 INFO - PROCESS | 1675 | RSS: Main: 287670272 02:08:29 INFO - PROCESS | 1675 | 02:08:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:08:32 INFO - PROCESS | 1675 | RSS: Main: 287584256 02:08:32 INFO - PROCESS | 1675 | 02:08:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 02:08:35 INFO - PROCESS | 1675 | RSS: Main: 286814208 02:08:35 INFO - PROCESS | 1675 | 02:08:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 02:08:39 INFO - PROCESS | 1675 | RSS: Main: 288378880 02:08:39 INFO - PROCESS | 1675 | 02:08:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 02:08:42 INFO - PROCESS | 1675 | RSS: Main: 289746944 02:08:42 INFO - PROCESS | 1675 | 02:08:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:44 INFO - PROCESS | 1675 | RSS: Main: 322580480 02:08:44 INFO - PROCESS | 1675 | 02:08:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:47 INFO - PROCESS | 1675 | RSS: Main: 323117056 02:08:47 INFO - PROCESS | 1675 | 02:08:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:49 INFO - PROCESS | 1675 | RSS: Main: 329846784 02:08:49 INFO - PROCESS | 1675 | 02:08:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:08:52 INFO - PROCESS | 1675 | RSS: Main: 331026432 02:08:52 INFO - PROCESS | 1675 | 02:08:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:08:56 INFO - PROCESS | 1675 | RSS: Main: 329990144 02:08:56 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 02:08:57 INFO - PROCESS | 1675 | RSS: Main: 391344128 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | __start_tp_report 02:08:57 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 02:08:57 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 02:08:57 INFO - PROCESS | 1675 | |i|pagename|runs| 02:08:57 INFO - PROCESS | 1675 | |0;ai-astar;111;106;110;108;110;112;116;111;111;111 02:08:57 INFO - PROCESS | 1675 | |1;audio-beat-detection;176;108;163;187;145;161;139;117;159;119 02:08:57 INFO - PROCESS | 1675 | |2;audio-dft;188;184;186;185;184;184;185;185;183;181 02:08:57 INFO - PROCESS | 1675 | |3;audio-fft;73;75;85;77;58;58;57;79;77;55 02:08:57 INFO - PROCESS | 1675 | |4;audio-oscillator;92;92;124;78;78;84;116;75;78;118 02:08:57 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;86;83;87;85;92;129;117;85;91;130 02:08:57 INFO - PROCESS | 1675 | |6;imaging-darkroom;93;92;95;93;93;93;93;94;92;93 02:08:57 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;84;86;84;85;87;86;86;84;86 02:08:57 INFO - PROCESS | 1675 | |8;json-parse-financial;54;53;54;54;52;53;53;64;55;52 02:08:57 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;64;63;72;74;69;67;68;68;68;66 02:08:57 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;83;83;84;82;82;80;84;82;86;87 02:08:57 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;134;110;143;132;126;135;117;119;129;136 02:08:57 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;141;129;140;141;139;121;144;141;140;139 02:08:57 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;68;67;68;67;67;67;69;67;67 02:08:57 INFO - PROCESS | 1675 | __end_tp_report 02:08:57 INFO - PROCESS | 1675 | __start_cc_report 02:08:57 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1247 02:08:57 INFO - PROCESS | 1675 | __end_cc_report 02:08:57 INFO - PROCESS | 1675 | __startTimestamp1457431737938__endTimestamp 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | ------- Summary: start ------- 02:08:57 INFO - PROCESS | 1675 | Number of tests: 14 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:2.59 (2.3%) stddev-sans-first:2.74 02:08:57 INFO - PROCESS | 1675 | Values: 111.0 106.0 110.0 108.0 110.0 112.0 116.0 111.0 111.0 111.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:160.00 stddev:26.48 (16.5%) stddev-sans-first:25.98 02:08:57 INFO - PROCESS | 1675 | Values: 176.0 108.0 163.0 187.0 145.0 161.0 139.0 117.0 159.0 119.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.50 Median:185.00 stddev:1.84 (1.0%) stddev-sans-first:1.45 02:08:57 INFO - PROCESS | 1675 | Values: 188.0 184.0 186.0 185.0 184.0 184.0 185.0 185.0 183.0 181.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:69.40 Median:76.00 stddev:11.14 (14.7%) stddev-sans-first:11.74 02:08:57 INFO - PROCESS | 1675 | Values: 73.0 75.0 85.0 77.0 58.0 58.0 57.0 79.0 77.0 55.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:78.00 stddev:18.84 (24.2%) stddev-sans-first:19.97 02:08:57 INFO - PROCESS | 1675 | Values: 92.0 92.0 124.0 78.0 78.0 84.0 116.0 75.0 78.0 118.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:85.50 stddev:19.02 (22.2%) stddev-sans-first:19.63 02:08:57 INFO - PROCESS | 1675 | Values: 86.0 83.0 87.0 85.0 92.0 129.0 117.0 85.0 91.0 130.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 02:08:57 INFO - PROCESS | 1675 | Values: 93.0 92.0 95.0 93.0 93.0 93.0 93.0 94.0 92.0 93.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 02:08:57 INFO - PROCESS | 1675 | Values: 85.0 84.0 86.0 84.0 85.0 87.0 86.0 86.0 84.0 86.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.50 (6.5%) stddev-sans-first:3.71 02:08:57 INFO - PROCESS | 1675 | Values: 54.0 53.0 54.0 54.0 52.0 53.0 53.0 64.0 55.0 52.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:3.31 (4.9%) stddev-sans-first:3.20 02:08:57 INFO - PROCESS | 1675 | Values: 64.0 63.0 72.0 74.0 69.0 67.0 68.0 68.0 68.0 66.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:2.06 (2.5%) stddev-sans-first:2.18 02:08:57 INFO - PROCESS | 1675 | Values: 83.0 83.0 84.0 82.0 82.0 80.0 84.0 82.0 86.0 87.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:133.00 stddev:10.12 (7.6%) stddev-sans-first:10.50 02:08:57 INFO - PROCESS | 1675 | Values: 134.0 110.0 143.0 132.0 126.0 135.0 117.0 119.0 129.0 136.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:140.50 stddev:7.00 (5.0%) stddev-sans-first:7.30 02:08:57 INFO - PROCESS | 1675 | Values: 141.0 129.0 140.0 141.0 139.0 121.0 144.0 141.0 140.0 139.0 02:08:57 INFO - PROCESS | 1675 | 02:08:57 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 02:08:57 INFO - PROCESS | 1675 | Values: 67.0 68.0 67.0 68.0 67.0 67.0 67.0 69.0 67.0 67.0 02:08:57 INFO - PROCESS | 1675 | -------- Summary: end -------- 02:08:57 INFO - PROCESS | 1675 | 02:08:58 INFO - TEST-INFO | 1675: exit 0 02:08:58 INFO - TEST-OK | kraken | took 56771ms 02:08:58 INFO - SUITE-END | took 1170s 02:08:59 INFO - Completed test suite (00:19:30) 02:08:59 INFO - javascript benchmark 02:08:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2976.8809247630084, 3469.531613232213, 3500.579930408351, 3522.1370764162784, 3547.130952916536, 5592.133219351007, 5601.8039368622, 5615.634983726055, 5616.971915140423, 5631.239782629349, 5579.079451890433, 5661.60368774186, 5698.51562617178, 5702.77188912444, 5729.799457019005, 5060.266261392096, 5081.212412076125, 5118.539331460168, 5130.179171332587, 5208.791648334062, 5181.4300426953005, 5199.792008319662, 5242.266082748418, 5258.395284542269, 5291.365036195662, 5054.949450505503, 5081.542661160476, 5150.278960945452, 5162.845114646567, 5190.532852043334, 5114.718690472023, 5133.255677926717, 5136.357955255593, 5148.227765835118, 5153.587712982952, 5095.3376061112185, 5129.9230511542355, 5140.1518749406305, 5147.176451767699, 5173.249878767558, 5486.451354864522, 5585.078462053756, 5612.550995920316, 5696.458836410535, 5700.230468886689, 6176.197094377702, 6186.4741496972365, 6188.504919606421, 6202.875942481125, 6215.098810672427, 6203.348648391944, 6264.3422440643535, 6266.060090986343, 6268.028455589391, 6268.247810262752, 5624.268845050117, 5727.570432217601, 5744.798932037401, 5846.239988801429, 5847.532197424196, 6249.281332646804, 6268.561200715906, 6269.592476489013, 6273.65494897785, 6278.340774218641, 5872.530197584183, 6033.42682445167, 6153.538484613582, 6155.199824022938, 6163.630182189083, 6134.478569321657, 6149.524114212646, 6175.938240617626, 6254.968725156436, 6264.467520260738, 6165.876682466325, 6170.691465426711, 6178.969105154445, 6181.0, 6191.040388739752, 6179.16581261533, 6201.255849298022, 6205.782797602063, 6217.720202590895, 6222.968885155636, 4703.45910220329, 4766.594839438617, 4811.615070794328, 4825.227963525819, 4930.2851086592245, 4393.802278897458, 4418.293073108287, 4422.226110430662, 4456.197884380777, 4458.71018383804, 5677.51741102011, 5678.5741069419955, 5688.203651488795, 5694.544436445074, 5698.202251684685, 6155.984262596711, 6175.938240617626, 6176.876462470816, 6266.248050234001, 6294.622322660655, 5724.398938111438, 5743.1385292206505, 5744.0522313817755, 5747.712614369265, 5771.653700777967, 4584.0, 5359.866003349869, 5372.435894231049, 5390.487903649226, 5394.973025134849, 6191.318954914956, 6298.212723409574, 6377.71300291488, 6409.55133140685, 6425.068365087036, 6227.501799856092, 6250.968745156245, 6257.530685198537, 6273.560850740587, 6284.748610055546, 6159.815205543661, 6356.872862542631, 6357.682115894279, 6360.840978975562, 6373.0, 6111.682900513496, 6115.082737589397, 6141.087915201912, 6202.0, 6241.625502469867, 6263.342349053284, 6276.246850377984, 6290.150829637941, 6290.811275661737, 6299.779507717208, 5874.324452687824, 5982.760689572368, 6125.785597504066, 6153.938460615336, 6154.723037463235, 5966.701664916824, 5978.0, 6008.699565021644, 6011.879762404815, 6022.668753218615, 4790.784414701417, 4792.472827988988, 5880.382559831327, 5934.43622855828, 5957.463828255478, 6112.205413296243, 6114.419130182626, 6123.608384081089, 6124.479419249414, 6141.0, 5030.220315851049, 5811.94188058114, 5904.996150654313, 5938.109283607493, 5946.583739138218], "unit": "score", "name": "dojo.html", "value": 5656.089837234933}, {"lowerIsBetter": false, "replicates": [486.48918635432784, 562.8986782379176, 569.1377562992067, 571.1318795430946, 607.3835057416723, 26562.07032753854, 38390.232195356075, 38438.0, 38460.03849903754, 38534.036649083784, 42468.362974555406, 42724.57275427253, 42814.57185428145, 42871.78564107183, 43034.0, 7234.710611575544, 9727.951360243223, 9734.318597698164, 9740.610375584969, 9756.170725488342, 9538.713838584854, 9641.084097010773, 9716.417014979088, 9736.513174341255, 9841.852372214422, 9805.901940980606, 9901.257405694565, 9902.455364954925, 9904.950475247613, 9911.306208565404, 9784.90215097847, 9864.210863131004, 9864.654737084167, 9868.161206297473, 9886.505674716236, 9544.665936692183, 9667.70996870095, 9675.758106047335, 9685.32202745808, 9716.514174291256, 41403.7929810352, 41805.1638967219, 41879.790601047105, 41900.161996759896, 41918.58081419177, 3492.6681965213265, 3679.742418030739, 3853.133045064866, 3910.5893881142356, 4208.548050922427, 28954.855225723735, 29284.560731589045, 29357.70642293571, 29407.97072102466, 29907.700922990927, 2654.4292977010036, 2666.4933662604235, 2692.17888543994, 2752.6146339512284, 2793.5809628555676, 490467.0, 490515.0, 491811.54094229656, 492503.53748231387, 492741.0, 46568.30147547789, 67565.32434675591, 68663.31336686669, 69664.30335696679, 69690.3030969694, 45991.0, 46234.76882615632, 46301.0, 46312.30531542029, 46347.07305853864, 16088.919555402148, 16285.674286514204, 16306.103164326076, 16306.836931630532, 16345.182740862909, 13028.739425211632, 13051.608451746462, 13060.934695326652, 13087.149335293176, 13088.08383413171, 15108.0, 15117.319720612599, 15126.773098403533, 15166.772498412533, 15267.541973740805, 6354.904676429857, 6457.709403076873, 6484.221893372825, 6489.8702025960165, 6501.577397469149, 952.4333021851987, 960.9807803843884, 979.7991411760572, 980.9411435313762, 1086.766345235778, 29671.109866704035, 30084.0, 30157.246068848017, 30234.697653023628, 30539.541906871415, 1093.0763504838399, 1117.6032508459543, 1128.7516746315798, 1203.7764756210238, 1243.2354102227246, 15095.32071056805, 15153.924230378778, 15167.393304267927, 15618.062916225063, 15645.530634080997, 520683.0, 973098.0, 984116.0, 985468.0, 986229.0, 62286.0, 62642.68678656578, 63211.367886321466, 63361.36638633647, 63565.0, 1335.79963005548, 1355.491690616019, 1438.496526215837, 1462.444271176946, 1482.0811097119854, 26325.605115922892, 30953.226169345045, 31029.0691279262, 31736.04791856248, 31893.68106319, 55210.723946380014, 55335.0, 56119.877602446904, 56125.0, 56129.43870561242, 404742.0, 407384.0, 407931.0, 408066.0, 409084.0, 29066.56400153957, 32753.34493310168, 33000.01999880015, 33474.163145920575, 34075.97772066842, 35171.0, 42207.577924220364, 42496.15007699767, 42838.57161428346, 43767.78116109399, 34536.82731586326, 35705.0, 36029.45955810612, 36578.634213657526, 36596.63403365932, 27541.44917101687, 35216.11959701028, 35578.644213557534, 35847.82076089603, 36117.27765444729, 35690.0, 36063.63936360708, 36326.636733632324, 36539.08652283714, 36792.81603591965, 28974.27564310909, 31646.841765791025, 32694.509582355808, 32826.0, 32836.83581582077, 23028.884855575616, 24290.75709242885, 24460.0, 24610.89250983746, 24790.628140578265], "unit": "score", "name": "ext.html", "value": 19671.072686152707}, {"lowerIsBetter": false, "replicates": [312.5062401405779, 358.7632162772569, 366.5711117991949, 366.88443140410766, 370.8460988689691, 20574.971251437444, 20905.163793448264, 21367.35897923061, 21397.893010534925, 21420.144374012652, 19930.501737456572, 20468.488287792814, 20748.377548673565, 20755.0, 20774.792252077474, 4284.807183676734, 5265.526102650761, 5306.8407947761625, 5310.62825602208, 5319.521243088121, 3352.513885486603, 3883.864064757734, 4456.532064133268, 5139.280500729901, 6398.71205795738, 5650.858728531799, 6356.364363563653, 6358.427741503264, 6364.777232796853, 6365.077063825743, 5703.62926409782, 5826.271716035496, 5828.271466066699, 6331.55679102463, 6342.365763423667, 5533.557315414757, 5567.3040869891265, 5579.860503487445, 5584.664920104807, 5607.80372686954, 13577.728445431036, 13665.701758332942, 13889.652758681113, 13921.23433211173, 13935.930320348434, 2172.598069357174, 2392.318189316054, 2475.26979541034, 2771.722827717212, 2778.2498725344244, 9416.340856140074, 9752.804943901083, 10133.03736145065, 12479.108082506415, 14785.926070369687, 1711.093120646047, 1718.269735362466, 1753.2723919573361, 1799.0824679413463, 1802.9008404537744, 84228.57885710594, 107245.0, 111505.88494115036, 114500.0, 118138.8186118145, 10744.785104297871, 11300.208985370946, 11313.490892909838, 11354.432278386048, 11479.311241325548, 13511.459541618422, 13568.93215533916, 13609.251491167883, 13622.978276629094, 13659.112157709716, 8581.828363432696, 8640.956795216109, 8652.956735216283, 8688.869666955, 8765.912340876637, 9004.8649270261, 9031.81936361269, 9042.502662353634, 9051.95902471211, 9142.451452912846, 4518.615917647036, 4569.588737013684, 4586.931196032062, 4590.357349971006, 4613.123506533815, 1831.9908400457912, 1891.3569386408687, 1905.4569447707613, 1910.2550005497867, 1943.5626983928785, 777.5140537164273, 826.1738261738262, 874.8906386701663, 931.888173419194, 935.9766005849772, 20275.986200689906, 20578.588428231353, 21320.933953302272, 21405.78594214069, 21507.354779356643, 812.7764864662147, 920.3649481857497, 925.847235206197, 934.1965909317981, 992.2607657295362, 11138.443077846076, 11468.254563453349, 11476.196666233283, 11502.654920352403, 11503.367314797766, 557909.4209057939, 590599.0, 590866.0, 609680.0, 624501.0, 117732.0, 120076.0, 120393.0, 130262.0, 138605.0, 1000.314784372707, 1025.4411345816548, 1046.5447530324334, 1047.3401756893109, 1049.5591851422573, 18840.811591883907, 18849.057547122862, 18876.0, 19189.520261993002, 19197.0, 51383.74308128585, 51603.0, 53099.0, 54419.72790136024, 55051.44948550463, 60830.78338433295, 77087.0, 78393.43213135819, 78410.21589784029, 78512.60743696245, 7882.330001949669, 8012.599370031592, 8029.799255018671, 8185.058718247477, 8202.507849529047, 11713.1800773945, 13084.476620935056, 13158.868411316147, 13404.32978351059, 13507.39216735269, 10724.356538607708, 10895.96488333607, 11040.558377665126, 11146.777064458827, 11515.136364772508, 10998.670039898816, 11164.553417863519, 11270.830937536108, 11434.371109589052, 11508.194426390408, 10890.564377424815, 11070.778584428428, 11339.0, 11676.649700508999, 11753.236039657395, 7956.920430795618, 8016.198380161937, 8123.3501319893085, 8137.877931831145, 8324.791880202802, 8169.918300816916, 9578.664746733832, 10748.516316765921, 10753.1935104869, 10899.618513351994], "unit": "score", "name": "jquery.html", "value": 9318.430482650434}, {"lowerIsBetter": false, "replicates": [1464.0264224290847, 1622.5943514121466, 1723.6380360124374, 1967.2917749610137, 2044.5093177637361, 8120.593970301484, 8571.571421428927, 8727.389082764217, 8754.737357879274, 8778.0, 8477.703280385187, 8759.781005474866, 8766.904136982877, 8773.210411063003, 8804.075572064938, 2184.803367696907, 2247.763984781599, 2252.279270633398, 2460.4341001569605, 2490.5641512735288, 2463.027104293812, 2527.721950585434, 2532.202356257773, 2535.21408363407, 2539.0, 2431.817613678981, 2473.6042233242683, 2480.937976550583, 2490.3276115448816, 2496.8002559795264, 2434.610462326037, 2471.9134830280946, 2473.492933948536, 2486.1422809131, 2504.0734928076545, 2475.517274131545, 2488.203774792067, 2488.5271798358253, 2495.8752062396807, 2502.5620516409554, 8907.910920890772, 8955.462672239686, 8963.775905602346, 8966.68616598416, 8983.640654373818, 5385.919211211835, 5601.103823388238, 5606.467385598403, 5609.382967873531, 5620.690862002588, 3551.7691350062423, 3640.4903313536124, 3683.4290684943876, 3699.648533389324, 3717.739758216926, 1017.867677201959, 1022.5143057047843, 1022.6931920423917, 1035.59094157808, 1040.505759764106, 10029.548670309854, 12183.695407614792, 12197.390130493528, 12198.024158067334, 12208.450619722134, 4846.927296090562, 4896.706197628154, 5000.824971126066, 5009.7495125243595, 5016.623753218523, 10096.444695541815, 10285.691429257135, 10303.639372621923, 10307.330023548446, 10322.071013608662, 4743.146233677902, 5556.861078473071, 5563.860903477445, 5570.61005729595, 5576.832695019156, 4491.371208030879, 4624.606908412823, 4832.613390928717, 5051.06555287273, 5068.265101560327, 3916.80537436079, 3925.0776067624083, 3957.8021098944937, 4045.554988951213, 4047.817848196838, 1138.2658185470325, 1303.5307289375817, 1318.698870471015, 1329.8404191497082, 1329.9202047877159, 1360.7550640884538, 1367.2958426410407, 1398.8880889528814, 1416.6458385403444, 1423.0963338280267, 8091.676332946734, 8251.257386835094, 8269.62786674601, 8276.50340979531, 8300.294474969574, 506.5846006274819, 509.1090591464936, 518.0623072239259, 518.2537146509015, 530.3821048478557, 6238.625682459067, 6243.43809057187, 6339.0808332791485, 6351.047342898602, 6384.936150638434, 10453.216008799218, 10829.83755243672, 10914.945425272823, 10929.781404371868, 10949.890501095046, 10307.639232626972, 10730.678079657622, 10759.83860242097, 10789.0, 10813.0, 8303.833923321621, 8316.916830831735, 8327.916720832834, 8363.83272334562, 8422.915770842335, 6517.8696426072165, 7684.961575192088, 7800.6099695016155, 7833.882491762514, 7944.285014348737, 9388.0, 9687.70936871895, 9689.806203875742, 9793.85309220348, 9810.460424676712, 9770.31607787448, 9974.700758977242, 9987.950060249652, 10109.595616175271, 10118.392896426238, 6869.965650171917, 7212.0, 7446.515976461513, 7586.62066896664, 7667.348275396431, 8263.793405164679, 8297.95851020741, 8302.54336011525, 8304.70933517324, 8317.0, 7244.0, 7394.704211831467, 7421.554706717614, 7488.9625551871895, 7563.848723025619, 7267.345938865316, 7308.524945878501, 7318.377937875341, 7323.816904577215, 7464.0, 7705.42209334291, 7720.034995625547, 7774.378049756119, 7784.844303113793, 7796.337311328373, 6956.826079348057, 6979.441644668313, 6997.545159564612, 7044.6125463100025, 7045.682944267418, 7077.5753454792875, 7086.0, 7140.357367836919, 7143.0, 7158.928410716035], "unit": "score", "name": "mootools.html", "value": 4877.968886114992}, {"lowerIsBetter": false, "replicates": [321.84068885901473, 327.1575692591576, 329.2673800793234, 332.39338207770817, 332.83524655295616, 6115.480184184338, 6526.347365263471, 6589.374009469105, 6598.5710928789595, 6611.4049735523795, 5734.971325143379, 6492.935070649292, 6518.543701940866, 6524.836879078025, 6526.282108968022, 4619.399478067863, 4724.503927087658, 4747.026859493795, 4766.928496072562, 4837.903241935159, 4671.766411679402, 4763.047390521892, 4766.6901651392545, 4780.737059461728, 4805.303231031498, 4672.97663511682, 4690.671652984292, 4712.646551508634, 4719.315699223627, 4725.763711814413, 4520.141173177086, 4713.2427529894885, 4757.452892917324, 4767.809287628491, 4785.641076919228, 3272.345530893831, 4055.7363771354767, 4057.1479989202007, 4060.8375664973364, 4076.1643863008308, 6194.442500175006, 6249.9062514062325, 6272.247330320345, 6274.937250627481, 6287.402696743802, 5628.634138781007, 5635.5773317001385, 5645.181448689958, 5648.068068768648, 5668.489835914787, 6940.757073502403, 6960.721571137148, 6966.477514186406, 6997.370236678673, 7001.614911179883, 3801.657850793442, 4313.15893400787, 4609.861704148881, 4612.607928326096, 4622.930656040162, 7288.489805713549, 7434.9256507434775, 7450.590217538033, 7486.737964171282, 7517.699292028367, 4596.057808149321, 4596.241620132708, 4598.839040633628, 4599.149157405891, 4599.9080018399445, 4661.790219440133, 4677.532246775295, 4683.953160468352, 4684.882877928079, 4688.742119183409, 5577.27495425592, 5577.358603760538, 5589.301337332833, 5589.74846131925, 5591.245181900473, 5061.0, 5878.911816322759, 6775.593464392152, 7026.754063607749, 7108.182559005677, 1595.4894433781078, 1609.0265389439455, 1622.691688579166, 1624.8618867396167, 1626.463267121847, 1025.738436698637, 1027.5170669785189, 1042.3537406807827, 1048.580567772897, 1052.2423854824515, 6377.489800815923, 6535.215774107042, 6559.737610495622, 6625.768098116543, 6744.831379215559, 7429.4799364044, 7439.590822504706, 7446.627668616547, 7449.962750186214, 7451.813704657427, 6708.362705543063, 6711.6979735912, 6712.0, 6715.227748808852, 6715.966420167965, 3861.131245469747, 3895.0846551060476, 3909.0, 3911.6675082618294, 3912.1002169501176, 6644.803935291694, 7518.473706840468, 7786.065672119382, 7798.727044553527, 7822.1786712395515, 6146.416090471398, 7376.520526165782, 7575.431842611826, 7620.733274335372, 7634.6182690865235, 7732.4200684948855, 7755.612219388895, 7758.728444504415, 7759.301662850257, 7763.0684317882215, 5962.850928726816, 7355.8161045974275, 7381.261873812576, 7383.852322953619, 7396.704131834882, 5809.331926828469, 6950.617716025465, 7192.604406757679, 7225.494215404871, 7232.74685386009, 7676.654550545127, 7737.0, 7737.3036426721865, 7747.883781743391, 7751.457397982087, 4577.382053422745, 4641.071785642953, 4641.071785642953, 4647.419072615923, 4649.651276154234, 7295.4528410368375, 7312.232215617496, 7329.157146928172, 7332.926670733438, 7344.96327518359, 6819.318068193141, 7085.078939737801, 7109.324614161646, 7138.928610713826, 7147.392471639969, 5749.712514374348, 6688.5619591788, 7077.292270772881, 7082.681279342545, 7107.182673992557, 5618.803341883178, 6040.275166979991, 6145.388210010817, 6744.325567443217, 6917.861642767217, 6809.897851532132, 7099.609521476162, 7102.18324892644, 7128.714851406093, 7144.892826607709, 6646.302138275411, 6786.253512113565, 6859.7256109757045, 6939.757108501179, 6978.546394484342], "unit": "score", "name": "prototype.html", "value": 5089.293420377923}, {"lowerIsBetter": false, "replicates": [679.1307126877597, 700.4851434195865, 739.2533541123464, 772.2740623813614, 799.8880156778049, 12384.504619815209, 15288.0, 15323.770143447857, 15329.386824527006, 15350.923245383772, 13798.586042418743, 13940.581782546515, 13996.510122145726, 14013.579592612212, 14013.789793153112, 751.9849603007937, 759.1876691939627, 909.9317551183672, 932.1703683721494, 935.9391639543442, 754.3625636337314, 906.7098528470859, 930.6882194464862, 935.046252822121, 935.9844568643031, 976.4239098931629, 984.3847595252967, 985.2167526816163, 985.231519414854, 991.3358050106445, 781.8944442500247, 978.8580655804903, 979.314479864098, 979.8432250839867, 980.5734505490099, 719.5574721546211, 729.8467321862415, 730.612775229124, 731.3417923868508, 732.1214542548962, 15002.324895379734, 15012.924935375362, 15060.849391506164, 15073.0, 15094.849051509455, 12272.32502212378, 12341.382930853422, 12551.372431378395, 12578.61635220125, 12668.68328291791, 9797.608095676236, 9905.35615185018, 10057.195424366033, 10130.341527800743, 10300.330478518872, 3469.5836499619954, 3557.217412169319, 3618.8914332570066, 3624.4958342288182, 3660.2313514162056, 80835.0, 81182.59408702978, 81777.59111204406, 83945.0, 84502.57748711217, 9564.808703825884, 9566.234701223886, 9661.46861922601, 9906.306558540977, 10008.699739007841, 22035.66946495804, 22044.11823527041, 22062.0, 22077.558448830932, 22090.33728988133, 7299.19708832028, 7432.2567743225245, 7436.107667079877, 7436.479446438698, 7490.02629658141, 3996.8800935971385, 4000.5199376074474, 4009.278329900588, 4016.8393264269102, 4069.9389509157386, 3628.5101511296166, 3668.3763760160837, 3686.705063594906, 3690.0774806298427, 3692.704583633357, 653.702565332782, 657.454312920275, 674.1640365946191, 683.8153698501377, 691.1326285511751, 513.5249893848176, 555.7221389305347, 589.9705014749245, 594.4204400709274, 598.6886818854172, 7928.7621371358955, 7950.761477155695, 8009.679612815422, 8117.350611951029, 8189.1401402853035, 541.5965105996058, 542.2435702195415, 585.0668184246206, 600.4431606853174, 600.5285850607339, 3705.7085392198355, 3726.8509259629855, 3776.905577360588, 3834.559025712079, 3862.4978752761963, 92504.0, 93635.06364936399, 94706.0, 94761.0, 94961.0, 79304.20695793083, 79859.0, 80596.59701701571, 80962.0, 81515.0, 70961.64519177475, 72166.0, 72218.0, 72619.0, 73550.0, 7287.489875708649, 7417.8887316689215, 7440.404767618686, 7543.660535276035, 7743.380529557735, 47419.525804742894, 47430.76284618555, 47613.0, 48230.553083407554, 48869.556522173036, 58233.70883145557, 62207.0, 68868.0, 69291.0, 70439.0, 10206.285560010729, 10263.435511046964, 10361.63734269297, 10433.530491127765, 10808.243422960317, 10816.783664326827, 10846.403447810131, 11108.666739997812, 11260.887391125983, 11482.081433485135, 9895.950520247641, 10133.543990520297, 10249.12882405004, 10468.738281543023, 10476.895231047592, 10076.94961525217, 10312.948435257777, 10319.432431216355, 11583.131265155316, 12324.876751232732, 11339.969677625306, 11358.602448914578, 11474.368909710047, 11642.0, 11847.466863991314, 9426.528673566432, 9532.904670953201, 9813.313068085166, 9878.851817222603, 10044.899551004688, 9392.0, 9594.18449431806, 9758.85361719589, 9785.266105042008, 9835.70492885186], "unit": "score", "name": "yui.html", "value": 6857.079814471356}], "name": "dromaeo_css", "value": 7489.618203410781}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 110.0, 108.0, 110.0, 112.0, 116.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [176.0, 108.0, 163.0, 187.0, 145.0, 161.0, 139.0, 117.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [188.0, 184.0, 186.0, 185.0, 184.0, 184.0, 185.0, 185.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.5}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 85.0, 77.0, 58.0, 58.0, 57.0, 79.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 124.0, 78.0, 78.0, 84.0, 116.0, 75.0, 78.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 87.0, 85.0, 92.0, 129.0, 117.0, 85.0, 91.0, 130.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 95.0, 93.0, 93.0, 93.0, 93.0, 94.0, 92.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 84.0, 85.0, 87.0, 86.0, 86.0, 84.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.3}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 54.0, 54.0, 52.0, 53.0, 53.0, 64.0, 55.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 72.0, 74.0, 69.0, 67.0, 68.0, 68.0, 68.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 84.0, 82.0, 82.0, 80.0, 84.0, 82.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.3}, {"lowerIsBetter": true, "replicates": [134.0, 110.0, 143.0, 132.0, 126.0, 135.0, 117.0, 119.0, 129.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.1}, {"lowerIsBetter": true, "replicates": [141.0, 129.0, 140.0, 141.0, 139.0, 121.0, 144.0, 141.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1420.8999999999999}]} 02:08:59 INFO - Return code: 0 02:08:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:08:59 INFO - # TBPL SUCCESS # 02:08:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:08:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:08:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:08:59 INFO - 2016-03-08 02:08:59.277 screenresolution[1679:10026] starting screenresolution argv=screenresolution get 02:08:59 INFO - 2016-03-08 02:08:59.279 screenresolution[1679:10026] Display 0: 1600x1200x32@60 02:08:59 INFO - 2016-03-08 02:08:59.285 screenresolution[1680:10029] starting screenresolution argv=screenresolution list 02:08:59 INFO - Available Modes on Display 0 02:08:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:08:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:08:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:08:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:08:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:08:59 INFO - Intel Iris: 02:08:59 INFO - Chipset Model: Intel Iris 02:08:59 INFO - Type: GPU 02:08:59 INFO - Bus: Built-In 02:08:59 INFO - VRAM (Dynamic, Max): 1536 MB 02:08:59 INFO - Vendor: Intel (0x8086) 02:08:59 INFO - Device ID: 0x0a2e 02:08:59 INFO - Revision ID: 0x0009 02:08:59 INFO - Displays: 02:08:59 INFO - Display: 02:08:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:08:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:08:59 INFO - Display Serial Number: 1600x1200 60 02:08:59 INFO - Main Display: Yes 02:08:59 INFO - Mirror: Off 02:08:59 INFO - Online: Yes 02:08:59 INFO - Rotation: Supported 02:08:59 INFO - Return code: 0 02:08:59 INFO - Running post-action listener: _resource_record_post_action 02:08:59 INFO - Running post-run listener: _resource_record_post_run 02:09:00 INFO - Total resource usage - Wall time: 1206s; CPU: 52.0%; Read bytes: 39323136; Write bytes: 704362496; Read time: 476; Write time: 1926 02:09:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398719488; Write bytes: 392074752; Read time: 29873; Write time: 708 02:09:00 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 37500416; Write bytes: 300675584; Read time: 456; Write time: 1187 02:09:00 INFO - Running post-run listener: _upload_blobber_files 02:09:00 INFO - Blob upload gear active. 02:09:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:09:00 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 02:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:09:00 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:09:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:02 INFO - (blobuploader) - INFO - Done attempting. 02:09:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:09:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:09:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:03 INFO - (blobuploader) - INFO - Done attempting. 02:09:03 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:03 INFO - Return code: 0 02:09:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:09:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cef3724cb46ad54bce1be4b196e99287c238ff5939327141d23b17ec9f0e275b2359578adfe23f54f1d48f4ab076125a5d091f008ca278570d61f2e3450c72ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb63b5843f1204fa8c1f153c230c7bbac49e70866a2eec67a4e84510373fb035f603a9f90847f40bf769e4ff2a97f7fa57e9c664eeb537d8e66c42e7de291d84"} 02:09:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:09:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:09:03 INFO - Contents: 02:09:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cef3724cb46ad54bce1be4b196e99287c238ff5939327141d23b17ec9f0e275b2359578adfe23f54f1d48f4ab076125a5d091f008ca278570d61f2e3450c72ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb63b5843f1204fa8c1f153c230c7bbac49e70866a2eec67a4e84510373fb035f603a9f90847f40bf769e4ff2a97f7fa57e9c664eeb537d8e66c42e7de291d84"} 02:09:03 INFO - Running post-run listener: copy_logs_to_upload_dir 02:09:03 INFO - Copying logs to upload dir... 02:09:03 INFO - mkdir: /builds/slave/test/build/upload/logs 02:09:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.672589 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-08 02:09:03.334879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:03.338297) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cef3724cb46ad54bce1be4b196e99287c238ff5939327141d23b17ec9f0e275b2359578adfe23f54f1d48f4ab076125a5d091f008ca278570d61f2e3450c72ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb63b5843f1204fa8c1f153c230c7bbac49e70866a2eec67a4e84510373fb035f603a9f90847f40bf769e4ff2a97f7fa57e9c664eeb537d8e66c42e7de291d84"} build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011587 build_url: 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cef3724cb46ad54bce1be4b196e99287c238ff5939327141d23b17ec9f0e275b2359578adfe23f54f1d48f4ab076125a5d091f008ca278570d61f2e3450c72ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb63b5843f1204fa8c1f153c230c7bbac49e70866a2eec67a4e84510373fb035f603a9f90847f40bf769e4ff2a97f7fa57e9c664eeb537d8e66c42e7de291d84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:03.366399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:03.366758) ========= 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.aDeqDdwgxt/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.iYM89sdrMD/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:03.415941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:03.416365) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:03.416738) ========= ========= Total master_lag: 3.63 =========