builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0154 starttime: 1459846869.61 results: success (0) buildid: 20160404235505 builduid: 1c0147a6cabd47fba5304dd16f551aa4 revision: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.613558) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.613952) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.614517) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005441 basedir: '/builds/slave/test' ========= master_lag: 0.29 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.908505) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.908810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.934918) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.935184) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005575 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.989300) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.989589) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.989960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:09.990260) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-05 02:01:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 132M=0s 2016-04-05 02:01:10 (132 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174689 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:10.279361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:10.279678) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.026208 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:10.386674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-05 02:01:10.387010) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-05 02:01:10,467 truncating revision to first 12 chars 2016-04-05 02:01:10,467 Setting DEBUG logging. 2016-04-05 02:01:10,467 attempt 1/10 2016-04-05 02:01:10,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/55fb4cbbdfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 02:01:12,525 unpacking tar archive at: mozilla-central-55fb4cbbdfae/testing/mozharness/ program finished with exit code 0 elapsedTime=2.306592 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-05 02:01:12.714616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:12.715011) ========= echo 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55fb4cbbdfaecc090c2d7ca13c022f933b445d6d'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d program finished with exit code 0 elapsedTime=0.005380 script_repo_revision: '55fb4cbbdfaecc090c2d7ca13c022f933b445d6d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:12.771686) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:12.772050) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 02:01:12.791046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-05 02:01:12.791494) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:12 INFO - MultiFileLogger online at 20160405 02:01:12 in /builds/slave/test 02:01:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:01:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:01:12 INFO - {'append_to_log': False, 02:01:12 INFO - 'base_work_dir': '/builds/slave/test', 02:01:12 INFO - 'blob_upload_branch': 'Firefox', 02:01:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:01:12 INFO - 'branch': 'Firefox', 02:01:12 INFO - 'buildbot_json_path': 'buildprops.json', 02:01:12 INFO - 'config_files': ('talos/mac_config.py',), 02:01:12 INFO - 'default_actions': ('clobber', 02:01:12 INFO - 'read-buildbot-config', 02:01:12 INFO - 'download-and-extract', 02:01:12 INFO - 'populate-webroot', 02:01:12 INFO - 'create-virtualenv', 02:01:12 INFO - 'install', 02:01:12 INFO - 'run-tests'), 02:01:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:01:12 INFO - 'download_minidump_stackwalk': True, 02:01:12 INFO - 'download_symbols': 'ondemand', 02:01:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:01:12 INFO - 'tooltool.py': '/tools/tooltool.py', 02:01:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:01:12 INFO - '/tools/misc-python/virtualenv.py')}, 02:01:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:01:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:01:12 INFO - 'installer_path': 'installer.exe', 02:01:12 INFO - 'log_level': 'info', 02:01:12 INFO - 'log_name': 'talos', 02:01:12 INFO - 'log_to_console': True, 02:01:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:01:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:01:12 INFO - 'opt_config_files': (), 02:01:12 INFO - 'pip_index': False, 02:01:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:12 INFO - 'cmd': ('bash', 02:01:12 INFO - '-c', 02:01:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:12 INFO - 'enabled': True, 02:01:12 INFO - 'halt_on_failure': False, 02:01:12 INFO - 'name': 'check_screen_resolution'},), 02:01:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:01:12 INFO - 'cmd': ('bash', 02:01:12 INFO - '-c', 02:01:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:01:12 INFO - 'enabled': True, 02:01:12 INFO - 'halt_on_failure': False, 02:01:12 INFO - 'name': 'check_screen_resolution'},), 02:01:12 INFO - 'run_cmd_checks_enabled': True, 02:01:12 INFO - 'sps_profile': False, 02:01:12 INFO - 'sps_profile_interval': 0, 02:01:12 INFO - 'suite': 'dromaeojs', 02:01:12 INFO - 'system_bits': '32', 02:01:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:01:12 INFO - 'title': 't-yosemite-r7-0154', 02:01:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:01:12 INFO - 'use_talos_json': True, 02:01:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:01:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:01:12 INFO - 'work_dir': 'build'} 02:01:12 INFO - ##### 02:01:12 INFO - ##### Running clobber step. 02:01:12 INFO - ##### 02:01:12 INFO - Running pre-action listener: _resource_record_pre_action 02:01:12 INFO - Running main action method: clobber 02:01:12 INFO - rmtree: /builds/slave/test/build 02:01:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:01:14 INFO - Running post-action listener: _resource_record_post_action 02:01:14 INFO - ##### 02:01:14 INFO - ##### Running read-buildbot-config step. 02:01:14 INFO - ##### 02:01:14 INFO - Running pre-action listener: _resource_record_pre_action 02:01:14 INFO - Running main action method: read_buildbot_config 02:01:14 INFO - Using buildbot properties: 02:01:14 INFO - { 02:01:14 INFO - "project": "", 02:01:14 INFO - "product": "firefox", 02:01:14 INFO - "script_repo_revision": "production", 02:01:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:01:14 INFO - "repository": "", 02:01:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:01:14 INFO - "buildid": "20160404235505", 02:01:14 INFO - "pgo_build": "False", 02:01:14 INFO - "basedir": "/builds/slave/test", 02:01:14 INFO - "buildnumber": 201, 02:01:14 INFO - "slavename": "t-yosemite-r7-0154", 02:01:14 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:01:14 INFO - "platform": "yosemite_r7", 02:01:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:01:14 INFO - "branch": "mozilla-central", 02:01:14 INFO - "repo_path": "mozilla-central", 02:01:14 INFO - "revision": "55fb4cbbdfaecc090c2d7ca13c022f933b445d6d", 02:01:14 INFO - "stage_platform": "macosx64", 02:01:14 INFO - "builduid": "1c0147a6cabd47fba5304dd16f551aa4", 02:01:14 INFO - "slavebuilddir": "test" 02:01:14 INFO - } 02:01:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:01:14 INFO - Running post-action listener: _resource_record_post_action 02:01:14 INFO - ##### 02:01:14 INFO - ##### Running download-and-extract step. 02:01:14 INFO - ##### 02:01:14 INFO - Running pre-action listener: _resource_record_pre_action 02:01:14 INFO - Running main action method: download_and_extract 02:01:14 INFO - mkdir: /builds/slave/test/build/tests 02:01:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:14 INFO - https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:01:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:01:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:01:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:01:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 02:01:18 INFO - Downloaded 1199 bytes. 02:01:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:01:18 INFO - Using the following test package requirements: 02:01:18 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:01:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:01:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:01:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'jsshell-mac.zip'], 02:01:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:01:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:01:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:01:18 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:01:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:01:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:01:18 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:01:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:01:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:18 INFO - https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:20 INFO - Downloaded 17959939 bytes. 02:01:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:01:23 INFO - Return code: 0 02:01:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 02:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:23 INFO - https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:01:26 INFO - Downloaded 17959939 bytes. 02:01:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 02:01:30 INFO - Return code: 0 02:01:30 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')]} 02:01:30 INFO - https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:01:31 INFO - Downloaded 10847584 bytes. 02:01:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:01:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 02:01:31 INFO - Return code: 0 02:01:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:31 INFO - https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:01:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:01:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:01:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:01:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 02:01:34 INFO - Downloaded 111355096 bytes. 02:01:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:01:34 INFO - mkdir: /builds/slave/test/properties 02:01:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:01:34 INFO - Writing to file /builds/slave/test/properties/build_url 02:01:34 INFO - Contents: 02:01:34 INFO - build_url:https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:01:35 INFO - Running post-action listener: _resource_record_post_action 02:01:35 INFO - Running post-action listener: set_extra_try_arguments 02:01:35 INFO - ##### 02:01:35 INFO - ##### Running populate-webroot step. 02:01:35 INFO - ##### 02:01:35 INFO - Running pre-action listener: _resource_record_pre_action 02:01:35 INFO - Running main action method: populate_webroot 02:01:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:01:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:01:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:01:35 INFO - '--tppagecycles', 02:01:35 INFO - '7'], 02:01:35 INFO - 'tests': ['tsvgm']}}, 02:01:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:01:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:01:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 02:01:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:01:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:01:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'tests': ['damp', 'tps']}, 02:01:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['damp', 'tps']}, 02:01:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:01:35 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['dromaeo_dom']}, 02:01:35 INFO - 'other': {'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'other_l64': {'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'other_nol64': {'tests': ['a11yr', 02:01:35 INFO - 'ts_paint', 02:01:35 INFO - 'tpaint', 02:01:35 INFO - 'sessionrestore', 02:01:35 INFO - 'sessionrestore_no_auto_restore', 02:01:35 INFO - 'tabpaint']}, 02:01:35 INFO - 'svgr': {'tests': ['tsvgx', 02:01:35 INFO - 'tsvgr_opacity', 02:01:35 INFO - 'tart', 02:01:35 INFO - 'tscrollx', 02:01:35 INFO - 'cart']}, 02:01:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['tsvgx', 02:01:35 INFO - 'tsvgr_opacity', 02:01:35 INFO - 'tart', 02:01:35 INFO - 'tscrollx', 02:01:35 INFO - 'cart']}, 02:01:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'tests': ['tp5o']}, 02:01:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'talos_options': ['--e10s'], 02:01:35 INFO - 'tests': ['tp5o']}, 02:01:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'talos_options': ['--xperf_path', 02:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:35 INFO - 'tests': ['tp5n']}, 02:01:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:01:35 INFO - 'talos_options': ['--e10s', 02:01:35 INFO - '--xperf_path', 02:01:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:01:35 INFO - 'tests': ['tp5n']}}, 02:01:35 INFO - 'talos.zip': {'path': '', 02:01:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:01:35 INFO - Running post-action listener: _resource_record_post_action 02:01:35 INFO - ##### 02:01:35 INFO - ##### Running create-virtualenv step. 02:01:35 INFO - ##### 02:01:35 INFO - Running pre-action listener: _resource_record_pre_action 02:01:35 INFO - Running main action method: create_virtualenv 02:01:35 INFO - Creating virtualenv /builds/slave/test/build/venv 02:01:35 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 02:01:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:01:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:01:35 INFO - Using real prefix '/tools/python27' 02:01:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:01:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:01:39 INFO - Installing pip.................done. 02:01:39 INFO - Return code: 0 02:01:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:39 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 02:01:39 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 02:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:39 INFO - 'HOME': '/Users/cltbld', 02:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:39 INFO - 'LOGNAME': 'cltbld', 02:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:39 INFO - 'MOZ_NO_REMOTE': '1', 02:01:39 INFO - 'NO_EM_RESTART': '1', 02:01:39 INFO - 'PAGER': '/bin/cat', 02:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:39 INFO - 'PWD': '/builds/slave/test', 02:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:39 INFO - 'SHELL': '/bin/bash', 02:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:39 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:39 INFO - 'USER': 'cltbld', 02:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:39 INFO - 'XPC_FLAGS': '0x0', 02:01:39 INFO - 'XPC_SERVICE_NAME': '0', 02:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:39 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 02:01:39 INFO - Cleaning up... 02:01:39 INFO - Return code: 0 02:01:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:39 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:39 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 02:01:39 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 02:01:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:39 INFO - 'HOME': '/Users/cltbld', 02:01:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:39 INFO - 'LOGNAME': 'cltbld', 02:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:39 INFO - 'MOZ_NO_REMOTE': '1', 02:01:39 INFO - 'NO_EM_RESTART': '1', 02:01:39 INFO - 'PAGER': '/bin/cat', 02:01:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:39 INFO - 'PWD': '/builds/slave/test', 02:01:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:39 INFO - 'SHELL': '/bin/bash', 02:01:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:39 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:39 INFO - 'USER': 'cltbld', 02:01:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:39 INFO - 'XPC_FLAGS': '0x0', 02:01:39 INFO - 'XPC_SERVICE_NAME': '0', 02:01:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:39 INFO - Downloading/unpacking psutil>=0.7.1 02:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:01:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:42 INFO - Installing collected packages: psutil 02:01:42 INFO - Running setup.py install for psutil 02:01:42 INFO - building 'psutil._psutil_osx' extension 02:01:42 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 02:01:43 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 02:01:43 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 02:01:43 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 02:01:43 INFO - building 'psutil._psutil_posix' extension 02:01:43 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 02:01:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:01:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:01:43 INFO - ^ 02:01:43 INFO - 1 warning generated. 02:01:43 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 02:01:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:01:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:01:43 INFO - Successfully installed psutil 02:01:43 INFO - Cleaning up... 02:01:44 INFO - Return code: 0 02:01:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:01: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')]} 02:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01: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')]} 02:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01: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', '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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 02:01: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 mozsystemmonitor==0.0.0 02:01:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:44 INFO - 'HOME': '/Users/cltbld', 02:01:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:44 INFO - 'LOGNAME': 'cltbld', 02:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:44 INFO - 'MOZ_NO_REMOTE': '1', 02:01:44 INFO - 'NO_EM_RESTART': '1', 02:01:44 INFO - 'PAGER': '/bin/cat', 02:01:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:44 INFO - 'PWD': '/builds/slave/test', 02:01:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:44 INFO - 'SHELL': '/bin/bash', 02:01:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:44 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:44 INFO - 'USER': 'cltbld', 02:01:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:44 INFO - 'XPC_FLAGS': '0x0', 02:01:44 INFO - 'XPC_SERVICE_NAME': '0', 02:01:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:01:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:01:46 INFO - Installing collected packages: mozsystemmonitor 02:01:46 INFO - Running setup.py install for mozsystemmonitor 02:01:46 INFO - Successfully installed mozsystemmonitor 02:01:46 INFO - Cleaning up... 02:01:47 INFO - Return code: 0 02:01:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:47 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:47 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 02:01:47 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 02:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:47 INFO - 'HOME': '/Users/cltbld', 02:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:47 INFO - 'LOGNAME': 'cltbld', 02:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:47 INFO - 'MOZ_NO_REMOTE': '1', 02:01:47 INFO - 'NO_EM_RESTART': '1', 02:01:47 INFO - 'PAGER': '/bin/cat', 02:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:47 INFO - 'PWD': '/builds/slave/test', 02:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:47 INFO - 'SHELL': '/bin/bash', 02:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:47 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:47 INFO - 'USER': 'cltbld', 02:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:47 INFO - 'XPC_FLAGS': '0x0', 02:01:47 INFO - 'XPC_SERVICE_NAME': '0', 02:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:47 INFO - Downloading/unpacking blobuploader==1.2.4 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01: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 02:01:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:01:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:01:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:01:50 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 02:01:50 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 02:01:50 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 02:01:50 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 02:01:50 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 02:01:50 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 02:01:50 INFO - Downloading docopt-0.6.1.tar.gz 02:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:01:51 INFO - Installing collected packages: blobuploader, requests, docopt 02:01:51 INFO - Running setup.py install for blobuploader 02:01:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:01:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:01:51 INFO - Running setup.py install for requests 02:01:51 INFO - Running setup.py install for docopt 02:01:51 INFO - Successfully installed blobuploader requests docopt 02:01:51 INFO - Cleaning up... 02:01:51 INFO - Return code: 0 02:01:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:51 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:51 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 02:01:51 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 02:01:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:51 INFO - 'HOME': '/Users/cltbld', 02:01:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:51 INFO - 'LOGNAME': 'cltbld', 02:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:51 INFO - 'MOZ_NO_REMOTE': '1', 02:01:51 INFO - 'NO_EM_RESTART': '1', 02:01:51 INFO - 'PAGER': '/bin/cat', 02:01:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:51 INFO - 'PWD': '/builds/slave/test', 02:01:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:51 INFO - 'SHELL': '/bin/bash', 02:01:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:51 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:51 INFO - 'USER': 'cltbld', 02:01:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:51 INFO - 'XPC_FLAGS': '0x0', 02:01:51 INFO - 'XPC_SERVICE_NAME': '0', 02:01:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Ief9BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ZaU71B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-OMv8i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-z0Tcs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ZIKUbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-i7aiBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Zm5UdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:52 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-ZzJnuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-axihHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-h8a76j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-8ODuqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-V2GiFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-5NhP1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-aTzzDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-rTb40v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-YsSXlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:53 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-iuQ56D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:01:53 INFO - Running setup.py install for manifestparser 02:01:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:01:54 INFO - Running setup.py install for mozcrash 02:01:54 INFO - Running setup.py install for mozdebug 02:01:54 INFO - Running setup.py install for mozdevice 02:01:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:01:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:01:54 INFO - Running setup.py install for mozfile 02:01:54 INFO - Running setup.py install for mozhttpd 02:01:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:01:54 INFO - Running setup.py install for mozinfo 02:01:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:01:54 INFO - Running setup.py install for mozInstall 02:01:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Running setup.py install for mozleak 02:01:55 INFO - Running setup.py install for mozlog 02:01:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Running setup.py install for moznetwork 02:01:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Running setup.py install for mozprocess 02:01:55 INFO - Running setup.py install for mozprofile 02:01:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:01:55 INFO - Running setup.py install for mozrunner 02:01:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:01:56 INFO - Running setup.py install for mozscreenshot 02:01:56 INFO - Running setup.py install for moztest 02:01:56 INFO - Running setup.py install for mozversion 02:01:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:01:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:01:56 INFO - Cleaning up... 02:01:56 INFO - Return code: 0 02:01:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:01:56 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:01:56 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 02:01:56 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 02:01:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:01:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:01:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:01:56 INFO - 'HOME': '/Users/cltbld', 02:01:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:01:56 INFO - 'LOGNAME': 'cltbld', 02:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:01:56 INFO - 'MOZ_NO_REMOTE': '1', 02:01:56 INFO - 'NO_EM_RESTART': '1', 02:01:56 INFO - 'PAGER': '/bin/cat', 02:01:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:01:56 INFO - 'PWD': '/builds/slave/test', 02:01:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:01:56 INFO - 'SHELL': '/bin/bash', 02:01:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:01:56 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:01:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:01:56 INFO - 'USER': 'cltbld', 02:01:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:01:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:01:56 INFO - 'XPC_FLAGS': '0x0', 02:01:56 INFO - 'XPC_SERVICE_NAME': '0', 02:01:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:01:56 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-3ojecd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:01:56 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)) 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:01:56 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-Z3oOMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:01:56 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)) 02:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:01:56 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-e8sE0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-oOhcFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-8dGXNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-yB_YW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-h_ap3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-dbD8dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-L6YInV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-RT2HWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-fTGC6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:01:57 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)) 02:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:01:57 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-fynSmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:01:58 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)) 02:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:01:58 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-FGQilM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:01:58 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)) 02:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:01:58 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-BcptC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:01:58 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)) 02:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:58 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-bsS9R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:01:58 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)) 02:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:01:58 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-kUDBlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:01:58 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)) 02:01:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:01:58 INFO - Running setup.py (path:/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/pip-L55e6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:01:58 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)) 02:01:58 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)) 02:01:58 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)) 02:01:58 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)) 02:01:58 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)) 02:01:58 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)) 02:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:01:58 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 02:01:58 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 02:01:58 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 02:01:58 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 02:01:58 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 02:01:58 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 02:02:01 INFO - Downloading blessings-1.6.tar.gz 02:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:02:01 INFO - Installing collected packages: blessings 02:02:01 INFO - Running setup.py install for blessings 02:02:01 INFO - Successfully installed blessings 02:02:01 INFO - Cleaning up... 02:02:01 INFO - Return code: 0 02:02:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:02:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:01 INFO - Reading from file tmpfile_stdout 02:02:01 INFO - Current package versions: 02:02:01 INFO - blessings == 1.6 02:02:01 INFO - blobuploader == 1.2.4 02:02:01 INFO - docopt == 0.6.1 02:02:01 INFO - manifestparser == 1.1 02:02:01 INFO - mozInstall == 1.12 02:02:01 INFO - mozcrash == 0.17 02:02:01 INFO - mozdebug == 0.1 02:02:01 INFO - mozdevice == 0.48 02:02:01 INFO - mozfile == 1.2 02:02:01 INFO - mozhttpd == 0.7 02:02:01 INFO - mozinfo == 0.9 02:02:01 INFO - mozleak == 0.1 02:02:01 INFO - mozlog == 3.1 02:02:01 INFO - moznetwork == 0.27 02:02:01 INFO - mozprocess == 0.22 02:02:01 INFO - mozprofile == 0.28 02:02:01 INFO - mozrunner == 6.11 02:02:01 INFO - mozscreenshot == 0.1 02:02:01 INFO - mozsystemmonitor == 0.0 02:02:01 INFO - moztest == 0.7 02:02:01 INFO - mozversion == 1.4 02:02:01 INFO - psutil == 3.1.1 02:02:01 INFO - requests == 1.2.3 02:02:01 INFO - wsgiref == 0.1.2 02:02:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:01 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:02:01 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 02:02:01 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 02:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:01 INFO - 'HOME': '/Users/cltbld', 02:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:01 INFO - 'LOGNAME': 'cltbld', 02:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:01 INFO - 'MOZ_NO_REMOTE': '1', 02:02:01 INFO - 'NO_EM_RESTART': '1', 02:02:01 INFO - 'PAGER': '/bin/cat', 02:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:01 INFO - 'PWD': '/builds/slave/test', 02:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:01 INFO - 'SHELL': '/bin/bash', 02:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:02:01 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:01 INFO - 'USER': 'cltbld', 02:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:01 INFO - 'XPC_FLAGS': '0x0', 02:02:01 INFO - 'XPC_SERVICE_NAME': '0', 02:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 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)) 02:02:01 INFO - Cleaning up... 02:02:01 INFO - Return code: 0 02:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:01 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:02:01 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 02:02:01 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 02:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:01 INFO - 'HOME': '/Users/cltbld', 02:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:01 INFO - 'LOGNAME': 'cltbld', 02:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:01 INFO - 'MOZ_NO_REMOTE': '1', 02:02:01 INFO - 'NO_EM_RESTART': '1', 02:02:01 INFO - 'PAGER': '/bin/cat', 02:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:01 INFO - 'PWD': '/builds/slave/test', 02:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:01 INFO - 'SHELL': '/bin/bash', 02:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:02:01 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:01 INFO - 'USER': 'cltbld', 02:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:01 INFO - 'XPC_FLAGS': '0x0', 02:02:01 INFO - 'XPC_SERVICE_NAME': '0', 02:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:02 INFO - Downloading/unpacking jsonschema 02:02:02 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 02:02:02 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 02:02:02 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 02:02:02 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 02:02:02 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 02:02:02 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 02:02:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:02:04 INFO - Downloading/unpacking functools32 (from jsonschema) 02:02:04 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 02:02:04 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 02:02:04 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 02:02:04 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 02:02:04 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 02:02:04 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 02:02:04 INFO - Downloading functools32-3.2.3-2.tar.gz 02:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:02:05 INFO - warning: no files found matching '*.txt' 02:02:05 INFO - no previously-included directories found matching 'build' 02:02:05 INFO - no previously-included directories found matching 'dist' 02:02:05 INFO - no previously-included directories found matching '.git*' 02:02:05 INFO - Installing collected packages: jsonschema, functools32 02:02:05 INFO - Running setup.py install for functools32 02:02:05 INFO - warning: no files found matching '*.txt' 02:02:05 INFO - no previously-included directories found matching 'build' 02:02:05 INFO - no previously-included directories found matching 'dist' 02:02:05 INFO - no previously-included directories found matching '.git*' 02:02:05 INFO - Successfully installed jsonschema functools32 02:02:05 INFO - Cleaning up... 02:02:05 INFO - Return code: 0 02:02:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:02:05 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 0x10f814a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f824420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f87dbcbbaa0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, '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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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 02:02:05 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 02:02:05 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 02:02:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:02:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:05 INFO - 'HOME': '/Users/cltbld', 02:02:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:05 INFO - 'LOGNAME': 'cltbld', 02:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:05 INFO - 'MOZ_NO_REMOTE': '1', 02:02:05 INFO - 'NO_EM_RESTART': '1', 02:02:05 INFO - 'PAGER': '/bin/cat', 02:02:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:05 INFO - 'PWD': '/builds/slave/test', 02:02:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:05 INFO - 'SHELL': '/bin/bash', 02:02:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:02:05 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:02:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:05 INFO - 'USER': 'cltbld', 02:02:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:05 INFO - 'XPC_FLAGS': '0x0', 02:02:05 INFO - 'XPC_SERVICE_NAME': '0', 02:02:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:02:05 INFO - Downloading/unpacking flake8 02:02:05 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 02:02:05 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 02:02:05 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 02:02:05 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 02:02:05 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 02:02:05 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 02:02:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:02:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:02:08 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 02:02:08 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 02:02:08 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 02:02:08 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 02:02:08 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 02:02:08 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 02:02:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:02:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:02:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:02:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:09 INFO - no previously-included directories found matching 'docs/_build' 02:02:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:02:10 INFO - Running setup.py install for pep8 02:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:02:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:02:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:02:10 INFO - no previously-included directories found matching 'docs/_build' 02:02:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:02:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:02:10 INFO - Cleaning up... 02:02:10 INFO - Return code: 0 02:02:10 INFO - Running post-action listener: _resource_record_post_action 02:02:10 INFO - Running post-action listener: _start_resource_monitoring 02:02:10 INFO - Starting resource monitoring. 02:02:10 INFO - ##### 02:02:10 INFO - ##### Running install step. 02:02:10 INFO - ##### 02:02:10 INFO - Running pre-action listener: _resource_record_pre_action 02:02:10 INFO - Running main action method: install 02:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:02:10 INFO - Reading from file tmpfile_stdout 02:02:10 INFO - Detecting whether we're running mozinstall >=1.0... 02:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:02:10 INFO - Reading from file tmpfile_stdout 02:02:10 INFO - Output received: 02:02:10 INFO - Usage: mozinstall [options] installer 02:02:10 INFO - Options: 02:02:10 INFO - -h, --help show this help message and exit 02:02:10 INFO - -d DEST, --destination=DEST 02:02:10 INFO - Directory to install application into. [default: 02:02:10 INFO - "/builds/slave/test"] 02:02:10 INFO - --app=APP Application being installed. [default: firefox] 02:02:10 INFO - mkdir: /builds/slave/test/build/application 02:02:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:02:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 02:02:44 INFO - Reading from file tmpfile_stdout 02:02:44 INFO - Output received: 02:02:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:02:44 INFO - Running post-action listener: _resource_record_post_action 02:02:44 INFO - ##### 02:02:44 INFO - ##### Running run-tests step. 02:02:44 INFO - ##### 02:02:44 INFO - Running pre-action listener: _resource_record_pre_action 02:02:44 INFO - Running main action method: run_tests 02:02:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:02:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:02:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:02:44 INFO - 2016-04-05 02:02:44.888 screenresolution[1646:7787] starting screenresolution argv=screenresolution get 02:02:44 INFO - 2016-04-05 02:02:44.890 screenresolution[1646:7787] Display 0: 1600x1200x32@60 02:02:44 INFO - 2016-04-05 02:02:44.896 screenresolution[1647:7789] starting screenresolution argv=screenresolution list 02:02:44 INFO - Available Modes on Display 0 02:02:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:02:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:02:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:02:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:02:45 INFO - Intel Iris: 02:02:45 INFO - Chipset Model: Intel Iris 02:02:45 INFO - Type: GPU 02:02:45 INFO - Bus: Built-In 02:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 02:02:45 INFO - Vendor: Intel (0x8086) 02:02:45 INFO - Device ID: 0x0a2e 02:02:45 INFO - Revision ID: 0x0009 02:02:45 INFO - Displays: 02:02:45 INFO - Display: 02:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:02:45 INFO - Display Serial Number: 1600x1200 60 02:02:45 INFO - Main Display: Yes 02:02:45 INFO - Mirror: Off 02:02:45 INFO - Online: Yes 02:02:45 INFO - Rotation: Supported 02:02:45 INFO - Return code: 0 02:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:02:45 INFO - Python 2.7.3 02:02:45 INFO - Return code: 0 02:02:45 INFO - grabbing minidump binary from tooltool 02:02:45 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')]} 02:02:45 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 0x10f6b3e00>, '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 0x10f4dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f6aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:02:45 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 02:02:45 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 02:02:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:02:45 INFO - Return code: 0 02:02:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:02:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:02:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:02:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:02:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:02:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:02:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:02:46 INFO - Return code: 0 02:02:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 02:02:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0154 --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 02:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wgXwQBYkxp/Render', 02:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:02:46 INFO - 'HOME': '/Users/cltbld', 02:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:02:46 INFO - 'LOGNAME': 'cltbld', 02:02:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:02:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:02:46 INFO - 'MOZ_NO_REMOTE': '1', 02:02:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:02:46 INFO - 'NO_EM_RESTART': '1', 02:02:46 INFO - 'PAGER': '/bin/cat', 02:02:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:02:46 INFO - 'PWD': '/builds/slave/test', 02:02:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:02:46 INFO - 'SHELL': '/bin/bash', 02:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bV6SGP3AT2/Listeners', 02:02:46 INFO - 'TMPDIR': '/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/', 02:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:02:46 INFO - 'USER': 'cltbld', 02:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:02:46 INFO - 'XPC_FLAGS': '0x0', 02:02:46 INFO - 'XPC_SERVICE_NAME': '0', 02:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:02:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0154', '--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 02:02:46 INFO - mozversion application_buildid: 20160404235505 02:02:46 INFO - mozversion application_changeset: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d 02:02:46 INFO - mozversion application_display_name: Nightly 02:02:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:02:46 INFO - mozversion application_name: Firefox 02:02:46 INFO - mozversion application_remotingname: firefox 02:02:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:02:46 INFO - mozversion application_vendor: Mozilla 02:02:46 INFO - mozversion application_version: 48.0a1 02:02:46 INFO - mozversion platform_buildid: 20160404235505 02:02:46 INFO - mozversion platform_changeset: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d 02:02:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:02:46 INFO - mozversion platform_version: 48.0a1 02:02:46 INFO - using testdate: 1459846966 02:02:46 INFO - actual date: 1459846966 02:02:46 INFO - starting webserver on 'localhost:49279' 02:02:46 INFO - SUITE-START | Running 2 tests 02:02:46 INFO - TEST-START | dromaeo_css 02:02:46 INFO - operating with platform_type : mac_ 02:02:46 INFO - Initialising browser for dromaeo_css test... 02:02:46 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpnyMvFS/profile http://localhost:49279/getInfo.html) 02:02:48 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 02:02:48 INFO - PROCESS | 1665 | colorDepth:24 02:02:48 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 02:02:48 INFO - PROCESS | 1665 | __metrics 02:02:48 INFO - PROCESS | 1665 | 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:02:48 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:02:49 INFO - TEST-INFO | 1665: exit 0 02:02:49 INFO - Browser initialized. 02:02:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:02:49 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpnyMvFS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:03:01 INFO - PROCESS | 1668 | RSS: Main: 235937792 02:03:01 INFO - PROCESS | 1668 | 02:03:52 INFO - PROCESS | 1668 | 1459847032421 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] 02:06:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 02:06:04 INFO - PROCESS | 1668 | RSS: Main: 317943808 02:06:04 INFO - PROCESS | 1668 | 02:09:06 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 02:09:07 INFO - PROCESS | 1668 | RSS: Main: 363020288 02:09:07 INFO - PROCESS | 1668 | 02:12:08 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 02:12:09 INFO - PROCESS | 1668 | RSS: Main: 358322176 02:12:09 INFO - PROCESS | 1668 | 02:15:11 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 02:15:12 INFO - PROCESS | 1668 | RSS: Main: 325513216 02:15:12 INFO - PROCESS | 1668 | 02:18:15 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 02:18:15 INFO - PROCESS | 1668 | RSS: Main: 323514368 02:18:15 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 02:21:18 INFO - PROCESS | 1668 | RSS: Main: 372051968 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | __start_tp_report 02:21:18 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 02:21:18 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 02:21:18 INFO - PROCESS | 1668 | |i|pagename|runs| 02:21:18 INFO - PROCESS | 1668 | |0;dojo.html;3381.154711322169;3392.338493993669;3401.6258211596705;3425.1265927188565;3507.105688049547;5547.140193270049;5630.971845140779;5638.718064096799;5654.802081927133;5668.461496157864;5615.157726341051;5695.145728140781;5705.686187259699;5710.971445142768;5731.168980497825;5094.210397388392;5131.435542090367;5158.793648254065;5170.327857378536;5173.5085166909275;5223.843284701465;5260.26356310115;5273.34083239595;5308.0710875596615;5326.680399176043;5118.33461649985;5135.743212839343;5234.97382513085;5238.711870847102;5272.894542109156;5202.2456743771945;5206.635535512516;5215.139501982168;5252.159654455307;5288.894222115575;5106.744662766884;5161.793528258865;5162.767675454614;5188.377394712621;5231.267622532849;5503.7798488060425;5629.802956896489;5634.295713035871;5636.013697602903;5644.6613203207935;6102.610439773209;6209.813705588839;6209.9068513972325;6224.782132625382;6231.376862313778;5828.388019258002;6264.686765661699;6275.7489700411925;6296.748130074791;6308.842278943063;5535.474129957647;5663.773449062074;5778;5785.074388097884;5791.073428251501;6194.783182588588;6280.654563999024;6281;6281.277653069956;6301.905471417932;6057.757689692363;6084.39156084388;6127.387261273837;6154.907676384858;6159.476444502178;6107.541934354941;6218.968905155445;6265.154204182377;6270.717817698214;6292.8426789329715;6116.969415152896;6156.6921653917125;6170;6179.0422484514975;6182.319944806068;6192.164057852222;6219.222597175353;6221.4089661482085;6232.407921247474;6249.500039996789;4776.808927642925;4854.611631069506;4860.149473842134;4877.926831097537;4912.582430493377;4358.5205627380965;4370.169667763115;4389.363542286351;4417.933730993974;4442.533533978885;5547.972260138674;5604.943950560442;5615.578831587647;5726.341470730836;5733.541316694655;6161.7227224775;6224.035274532454;6244.219472565929;6249.96875015622;6263.937360626335;5631.1271752878365;5632.831015069554;5653.886922261532;5661.631993920382;5681.0058239808695;5217.608679349064;5300.231466437345;5311.0174617695075;5338.332708411449;5391.7034563099405;6268.561200715906;6276.278228003838;6290.276618188876;6294.3076261612105;6297.055441683692;6210.347913469202;6244.937550624436;6264.592801468072;6269.49844012487;6271.592346497463;6182.072689096672;6220.066989951543;6273.74905003813;6280.874382512416;6290.528210384148;6135.386461353829;6143.232095988002;6145.231846019247;6153.6923153841235;6170.413810687977;6219.813405597839;6241.282252541016;6241.531885108726;6242.65665388408;6295.1186833842385;5951.970240148771;6026.186464827192;6027.156198132177;6028.2163318770035;6111.449969502766;6009;6066.484348830222;6082.2093127893095;6088.543359248163;6110.877782444238;5884.970575147268;5916.615419997686;5923.08192230205;5923.970380148072;5925.585209035326;5898.498627616529;5933.3769954154195;6020.187274717857;6057.363976782374;6074.362191969956;5118.718470484159;5988.850278743066;5989.251343582052;5991.071383935497;5991.430814072656 02:21:18 INFO - PROCESS | 1668 | |1;ext.html;489.86283840524663;574.9507149452251;583.9722089123142;618.8886000519906;628.6291088257927;30276.09171724849;37743.622563774356;37830.24339513215;37961.81019094904;38008.42987355188;40067.19865602686;40738.79630601843;40756.38865417021;41015;41204.58795412045;9415.811683766338;9678.903210967906;9721.902780972207;9723.367981081206;9732.65935692251;9528.904710952906;9684.370515916478;9686.903130968705;9694.903050969471;9704.90295097047;9538.523073846314;9619.615215391412;9700.951495242514;9706.320557560974;9727.610895564168;9590.08894155054;9656.324057315991;9662.178714809215;9671.661491847752;9676.274279429072;9494.95252523733;9520.047995200493;9660.661876834347;9662.56518456671;9662.806743865154;37844.24311513782;38181.809090954644;38209.61790382089;38222.61777382218;38389.80805095957;3253.544503769474;3305.0415379539904;3383.9830800846084;3386.475096360068;3819.4843696100947;28073.43853122926;28890.71109288922;29042.709572904212;29223.97716079927;29250.414991700047;2743.2181828178873;2763.4196818668106;2799.7060308667706;2845.9715402845914;2878.0502434196874;489416.1058389406;492737.53631231975;494462;494564;494816;43937.12125757467;44594.777026114665;44766.10467790626;62420.37579624236;62730;43773;43788.781056094514;43805.56194438015;44019.89950251205;44038;15337.6165595861;15441.30514126867;15444.382224710886;15503.689926201638;15506.379744810081;10949.014588686898;12116.333601651817;12161.635150945485;12163;12165.330906800034;14440.927795360956;14478.986470947144;14561.344739486749;14566.708665826836;14650.120992740469;6185.402926576914;6293.622382657055;6316.431521163117;6338;6340.968295158495;856.6573370651664;946.7680418297424;982.7150126463246;1059.6609085092696;1116.3971455413985;28281.71718282832;28577.096465430517;28937.7106228935;29057;29194.562081568794;988.2785566536324;1060.8037513060108;1062.8086944349936;1097.5664612478026;1192.5570060227049;14499;14632.853671463148;14814.703705925822;14824.555263342118;14939.402423902922;472896;477216;478972;482229;482913;57154.71422642943;57368.42631573631;57381.71309143428;57500;57792;1322.9338533073308;1435.2106341512126;1436.5115860607234;1475.8450362711976;1476.8227812662549;23172.18897338585;28423.43153136967;28624.57063144096;29310;29443.263918402212;44960.32559511675;45129;45356;45534.08931821279;45593.08813823639;339491;340514;341287;341395.9813415887;342829;27995.860020699765;31803;32720.509192361656;32745.836270818494;32813.17967050843;39679.2064158721;40440;40613.79693101515;40729.59270407258;41841;28748.712512874605;33555.496667549516;33674.49488257727;34621;35079.64920350764;28816.42367152687;31501.52747708832;33228;33350.499742503394;33969.66030339665;34863.30273394467;35049.64950350566;35871.28257434889;35909.820450897576;36000;30186.24534386658;30863.845680771454;30879.382412352075;31104.533431998992;31719.365612687154;23452.765472345058;23660.763392365858;23733.881330593238;23811.166609168595;24212.75787242105 02:21:18 INFO - PROCESS | 1668 | |2;jquery.html;312.7826160818232;353.7735849056604;357.2818634544565;360.19855820798716;368.4694040581562;18926.62146757064;19024;20078.89960550197;20080.59838803223;20129.59740805183;18688.345907893225;19547.21811127553;19876.50308742282;19888.403347899588;19913.40259792205;4919;5500.367457742361;5837.766489340422;5841.737121829507;5852.912206316909;4161.625453709165;4367.301231802912;4991.875203119933;5809.622374545641;6481.74073037078;6336.5881217720935;6397.136386587821;6406.487481001509;6413.4869210463285;6428.453581445583;6068.848278793043;6390.073439351291;6394.232692076934;6394.264659564116;6397.872042559146;3722.7766334019775;3906;3911.4328422378594;5294.602904782157;5523.8066667666435;23384.064637414653;23512.76487235123;24012;24759;24809.63547004914;2116.904739286736;2204.691343211952;2217.4788924602703;2599.922002339933;2657.9202623921315;13372.531961381304;13698.178109313472;14212.502562410265;14396.992210545266;14845.851541484662;1606.598350412397;1664.8085470170963;1770.1503278426428;1785.3394244129624;1786.0980204996524;95067.52466237693;98450;98453;98751.50624246904;100984.49507752415;9960.850587241197;10218.386896786216;10614.25700200994;10760.784784304271;10765.677029689123;13392.531261405804;13424.463021479227;13494.52769153075;13524.391402386917;13538.93230533841;8103.554304513191;8144.918550814416;8169.2647661710735;8179.877301840477;8259.545724985184;8179;8195.303399211014;8240.587970601446;8315.95842020786;8337.291330236876;4228.957710422918;4290.2706539888295;4301.720388174758;4333.133373325348;4348.369486424451;1518.2332921874383;1786.7314206913238;1792.4712209898112;1793.4350679536165;1794.0581194872536;786.2844811221761;921.0927236671873;944.8252073366449;953.7043516509904;1047.5966752800227;18345;18823.835258945124;18833;18980.810191897905;19369.4189174325;932.8554074118523;934.4299977014016;989.124624707125;1016.9237307201842;1033.0289527843802;10158.238132140119;10295.485225738683;10403.063724264852;10462.901395353378;10468.790624187473;550575;556130;562562;563707;566970;93092;112999;115760.84239157669;116047.41976290065;117137;918.1140199707181;952.2667545989688;954.4321128928276;965.6234068713208;966.9468179250209;14396.55215316205;17033;17632.118394080502;17791.932484050998;17804.198811053273;38932.6106738929;48235.55293341205;49914;50497.747511262205;52128;61778;72208.63895680488;72294;72748.27251727415;74355.7055368079;7486.5508069516;7514.736984205527;7523.7366692165515;7691.692332306645;7755.573443460664;10889.78220435571;12156.088293377856;12357.691057723268;12461.688457788629;12597.93701031489;10444.791104178026;10531.368117912949;10577.206709496664;10842.457877105955;10868.836967445653;10288.176945844165;10467.057964783206;10510.527026283988;10549.997750213717;10946.726331841768;10422.687319380431;10663.253572249869;10836;10900.07349375312;10902.50938707776;7452.366548843409;7632.656530456254;7753.147153812964;7853.45025848208;7899.565523896241;8110.06734225548;10041.849372259276;10471.21465890046;10900.400477973788;10910.61812836547 02:21:18 INFO - PROCESS | 1668 | |3;mootools.html;1551.774992626069;1573.7245981953156;1833.6332733453305;1941.2041063164106;1975.1803001754272;8749.081346458617;8826.338024648161;8933.4193277437;8961.686340978067;8969.506677132755;7863.8034049148655;8052.758417247477;8515.701950431736;8702.260307873838;8797.648094076229;2405.699287589047;2491.9377015574664;2494.4138127540014;2495.126705653016;2497.12600589793;2181.825453963679;2317.617593097137;2363.243761996162;2411.807055435561;2415.323709361373;2199.25225423356;2427.332483567024;2480.441900572375;2483.6026235802274;2484.1429706751233;2440.987795061022;2455.852648841066;2456.7051953765485;2476.2695004973575;2479.095130277454;1958.6278607064612;2311.5492478966607;2343.7773411525877;2346.21401830387;2366.337425520857;8799.648014079428;8911;8912.821743565093;8916.910830891673;8926.642934282685;5414.485623865727;5600.775968961237;5623.887522249532;5628.690422026787;5634.211210430543;3547.6807087362004;3644.2529281497227;3664.76179048361;3676.8345424455965;3687.1519550503267;1045.968620941373;1054.9525271362807;1056.7675111475462;1065.0999905080196;1076.2896488317672;10238.283320167591;12148.21036632616;12193.329366884818;12196.329201893892;12227.388630568525;4802.807887684523;4849.660523763373;4936.950630493649;4947.1837146871085;4951.430585482643;10194.592216311414;10203.438810865473;10205.795884082278;10210.591576336863;10220.233482488844;5481.698506582176;5544.556435485151;5567.693776842231;5577.832665020056;5590.888182236333;4977.228529577921;5001.624878134082;5004.974975125101;5060.924086138711;5068.366454193226;3891.747036442622;3922.9215415692097;3972.880813575597;3974.9801250994137;3976.8011599420493;1090.5038207615673;1196.5931583261734;1250.7936190528642;1262.9431675574622;1330.4212667489674;1005.6731562242301;1026.2610920137488;1112.9888701113048;1262.6906407930117;1376.5250988408982;8018.4787988780545;8027.438079334391;8111.797205069921;8117.472364296302;8128.796780080427;1175.488662431845;1178.269472926791;1180.7579446213506;1207.6075275535486;1208.3112625803208;6128.417800308964;6242.09489624002;6243.719032643542;6254;6259.405356491126;10075.19398448137;10491.842622360671;10491.895081049244;10567.048965593134;10585;10171.54228059739;10408.843867341995;10430.478476076165;10450.790984180274;10459.686209413578;8127.268545830903;8256.844041834149;8265.586720663943;8272.710455134162;8341.374396920255;7938.404619653665;7989.960050199712;8004.239597238253;8134.430589858653;8251.422400431911;8606.78483037929;9576.042395760369;9670.178034867115;9735.756606084622;9879.555420005972;9746.805063898824;9866.16137628281;10023.148032417326;10072.647457338959;10186.949065254626;7534.811629709301;7539.962300188464;7557.5465472071855;7636.31273185416;7670.463067585216;8202.753917382488;8214.383921205814;8256.463329883538;8290.626921788413;8321.417500774887;6172.22847144107;7353.852922941618;7487.700491980478;7629.351505122127;7637.961810191136;7175.928240717735;7193.964030179815;7237.529560578546;7268.200497945328;7274.30894065063;6591.96704016496;7553.962230188814;7648.502847314907;7678.884816727642;7709.961450192937;6642.103316052271;6734.9326506734305;6736.259011508828;6742.898856517058;6756.121704178426;6878.518503704893;7091.787246382617;7095.290470952863;7113.679884405111;7133.144022717307 02:21:18 INFO - PROCESS | 1668 | |4;prototype.html;252.36026672385506;321.695997282568;322.12382320089347;328.43837038663867;328.9194147433879;6366.936330636692;6492.448141907944;6532.183477065367;6562.212534495867;6641.667916604175;6430.260520040197;6472.51456140789;6491.2859585445685;6521.445677117451;6531.869362612745;4577.359169716243;4688.953110468903;4703.270992996091;4805.3032310315075;4829.4446138693975;3788.677962373202;4800.591949684281;4813.518648135194;4816.109019831342;4818.662693611449;4767.356406885061;4768.713877167381;4776.426828780551;4785.521447855222;4791.928121078186;4530.184566777995;4603.654725895538;4606.884827879297;4657.324687920266;4771.045790841828;3450.9482357764405;3953.584873588289;4018.799060046986;4029.073313137995;4029.959700403017;6151.569390142692;6182.876342473125;6191.473724733403;6208.875822483525;6236.220472440945;5480.725963701839;5496.1755736639425;5496.340439147288;5502.8349149525575;5503.532199762985;6818.4886133540185;6819.045333653293;6820.727170913157;6833.3166683331765;6834.266293482597;3551.6093229744706;4289.571042895716;4437.29003359461;4439.400680908101;4466.754328511931;7127.893081603728;7169.5698258104685;7249.021382113453;7252.70989160433;7270.9093635954505;4558.840440584564;4559.38448309474;4560.361549383089;4572.81708731647;4578.679492435497;3815.5802861685193;4600.263957766741;4609.331646911179;4621.1219868224925;4627.1439783640135;4708.764561771898;5281.9207711884355;5490.3411590609385;5514.448555144534;5529.170624406372;5976.970115149484;6679.532432729759;6913.75801846933;6959.478039147084;6965.895511567331;1371.7736573465465;1579.7393430083907;1581.9604509887345;1592.33122088723;1601.391471240921;1015.8019186258608;1018.7351288665001;1035.4460363705532;1039.5322105052755;1039.604950118965;6051.364606716319;6186.721597528122;6291.55959082869;6335.65153916539;6510.837229069217;6497.642629655415;6717.596944183365;7212.242714515005;7223.674934627954;7231.168415632164;6400.839979000562;6415.647139407284;6424.518161137933;6425.3574642536305;6453.741850326029;3764.153065560282;3814.675752561008;3825.8087095645105;3831.885043448701;3840.1935593525673;7267.127944646676;7452.403807695371;7525.962370188114;7535.284148005931;7572.4699271050495;6488.416042556192;7137.4290056795335;7441.925580744231;7482.6632801524065;7517.323440890346;6056.485198758155;7525.134609519756;7527.2849079337375;7543.547387156678;7547.811304717426;7166.462515311268;7183.461240406886;7189.245129261352;7193.172785129568;7222.349988501061;6847.589144651337;7091.326323999212;7108.111486064242;7115.146182458138;7120.53716508446;7469.701211951461;7517.473776835569;7518.248175182438;7533.886991695239;7537.434692398202;4564.8174073038035;4567.908641827211;4568.269076947672;4581;4591.609713174284;7153.928460715326;7157.463190260647;7180.569165849857;7181.712731490891;7181.784546463615;5640.548756099584;6584.407403333723;6764.830879228059;6837.1111755471475;6907.998340240738;6762.86474270502;6770.289119642367;6795.966020169867;6797.28628494001;6808.727650894107;6684.699188536625;6738.35985581369;6758.966205168943;6761.763338283136;6780.25417204117;6924.515283930278;6925.411340035952;6926;6927.307269273032;6937.445004399737;5462.945370546244;6535.869282614226;6698.229703583956;6715.5970641759695;6781.762638307636 02:21:18 INFO - PROCESS | 1668 | |5;yui.html;701.4003027411563;754.0950858969235;758.8482303539294;759.5556599389357;808.4906508899394;14945.775813362794;15088.17015064171;15136.848631513682;15145.242737863104;15209.315580798877;13662.590122296348;14391.424343026292;14409.495667651634;14421.423143074291;14433.711325773478;740.1857956248111;755.3805879179075;898.3127907151035;914.1498406481969;915.3180880244228;923.224491427201;924.2652091587204;925.6991477769718;928.3640706116298;930.50683137937;961.8172547216006;968.1238479176321;969.5394687523406;969.8933117357085;971.1599466461495;774.802425381527;956.7273327101777;958.6644674363987;974.3228456222928;977.1352353167426;688.4079691465336;711.5268346549539;726.0525014855612;727.9745208917662;728.351766927435;14824.925875370662;14860.479883204143;14879.553613391616;14899.47851825181;14902.329395177243;10751.395107310216;12451.190672606343;12536.937315313457;12546.247225166428;12909.67725806853;8282.337413006944;9862.556184971694;9885.357451765612;10297.639582614647;10776.353418794897;3450.87921922734;3510.473428985647;3515.402381595135;3530.258645684409;3617.5478065241846;71997;72057;72342.63828680875;72393;72627;9271.150274627584;9361.344705870524;9473.147416732527;9587.760305992266;9757.756056098655;21379.46551336229;21391.78608213929;21412.678809817866;21413;21435.249766258105;7160.749373771893;7399.223081576464;7419.369353605004;7599.278068583476;7600.50596711212;3371.9662803371652;4036.17202511838;4100.5899410059355;4178.331466965271;4181.519125300569;3075.4617941860533;3553.200529880808;3594.2272411431145;3595.478655594924;3603.1172362770762;571.0988180045359;629.6348118091588;641.2369280556217;644.2751904107879;645.0356716708551;488.64084897600236;528.2074703627987;573.8938296415093;602.0517684646699;602.6474512410201;7967.880481792778;8220.464730539235;8282.213189746964;8302.003759548772;8350.08149103598;513.0278122956976;566.498648695907;588.8174665853599;592.5496622566794;620.3424370167637;3802.2775672622115;3815.3895376740143;3832.7700337979254;3874.341361968472;3999.420084087791;81774;82048.17951820524;83295.583522082;84545;84628.73056904151;70438;70659.29340706527;70706.58586828235;71324.93012604814;71774;62959.74080518364;63316.68341658262;63462;64779.676101620134;64789.352106478334;7565.167831538636;7575.469717119749;7794.844103117793;7796.415268854972;7868.3727987583125;41638;42802.35796462993;44053.77973110242;45205;46452.53547464482;51434.74282628563;53631.731841340545;61252.69373653103;62046.069308961305;62242;10071.19430445548;10182.847257291294;10224.53989570486;10245.641402550875;10443.895561044292;10702.839457408301;10714.839277411002;10722.73193170177;10726.463676816284;10828.404437755999;10066.597336106766;10086.29395942277;10130.240231982483;10206.336588121749;10514.737131571466;10071.34536255141;10132.240081994027;10185.33795303303;10430.322029068086;10558.472076396303;9928;9960.701178964642;9970.152537034142;10217.74455638615;10272.948635256776;8641.436315027888;8652.653893844175;8900.42147260426;8963.05887881789;8980.595873185854;8665.43674661145;8752.78118047054;8765.956170219108;8769.254613357682;8942.552872356226 02:21:18 INFO - PROCESS | 1668 | __end_tp_report 02:21:18 INFO - PROCESS | 1668 | __start_cc_report 02:21:18 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1203 02:21:18 INFO - PROCESS | 1668 | __end_cc_report 02:21:18 INFO - PROCESS | 1668 | __startTimestamp1459848078585__endTimestamp 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | ------- Summary: start ------- 02:21:18 INFO - PROCESS | 1668 | Number of tests: 6 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5714.61 Median:5925.59 stddev:631.94 (10.7%) stddev-sans-first:606.78 02:21:18 INFO - PROCESS | 1668 | Values: 3381.2 3392.3 3401.6 3425.1 3507.1 5547.1 5631.0 5638.7 5654.8 5668.5 5615.2 5695.1 5705.7 5711.0 5731.2 5094.2 5131.4 5158.8 5170.3 5173.5 5223.8 5260.3 5273.3 5308.1 5326.7 5118.3 5135.7 5235.0 5238.7 5272.9 5202.2 5206.6 5215.1 5252.2 5288.9 5106.7 5161.8 5162.8 5188.4 5231.3 5503.8 5629.8 5634.3 5636.0 5644.7 6102.6 6209.8 6209.9 6224.8 6231.4 5828.4 6264.7 6275.7 6296.7 6308.8 5535.5 5663.8 5778.0 5785.1 5791.1 6194.8 6280.7 6281.0 6281.3 6301.9 6057.8 6084.4 6127.4 6154.9 6159.5 6107.5 6219.0 6265.2 6270.7 6292.8 6117.0 6156.7 6170.0 6179.0 6182.3 6192.2 6219.2 6221.4 6232.4 6249.5 4776.8 4854.6 4860.1 4877.9 4912.6 4358.5 4370.2 4389.4 4417.9 4442.5 5548.0 5604.9 5615.6 5726.3 5733.5 6161.7 6224.0 6244.2 6250.0 6263.9 5631.1 5632.8 5653.9 5661.6 5681.0 5217.6 5300.2 5311.0 5338.3 5391.7 6268.6 6276.3 6290.3 6294.3 6297.1 6210.3 6244.9 6264.6 6269.5 6271.6 6182.1 6220.1 6273.7 6280.9 6290.5 6135.4 6143.2 6145.2 6153.7 6170.4 6219.8 6241.3 6241.5 6242.7 6295.1 5952.0 6026.2 6027.2 6028.2 6111.4 6009.0 6066.5 6082.2 6088.5 6110.9 5885.0 5916.6 5923.1 5924.0 5925.6 5898.5 5933.4 6020.2 6057.4 6074.4 5118.7 5988.9 5989.3 5991.1 5991.4 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:57266.46 Median:36871.81 stddev:117788.57 (319.5%) stddev-sans-first:118041.86 02:21:18 INFO - PROCESS | 1668 | Values: 489.9 575.0 584.0 618.9 628.6 30276.1 37743.6 37830.2 37961.8 38008.4 40067.2 40738.8 40756.4 41015.0 41204.6 9415.8 9678.9 9721.9 9723.4 9732.7 9528.9 9684.4 9686.9 9694.9 9704.9 9538.5 9619.6 9701.0 9706.3 9727.6 9590.1 9656.3 9662.2 9671.7 9676.3 9495.0 9520.0 9660.7 9662.6 9662.8 37844.2 38181.8 38209.6 38222.6 38389.8 3253.5 3305.0 3384.0 3386.5 3819.5 28073.4 28890.7 29042.7 29224.0 29250.4 2743.2 2763.4 2799.7 2846.0 2878.1 489416.1 492737.5 494462.0 494564.0 494816.0 43937.1 44594.8 44766.1 62420.4 62730.0 43773.0 43788.8 43805.6 44019.9 44038.0 15337.6 15441.3 15444.4 15503.7 15506.4 10949.0 12116.3 12161.6 12163.0 12165.3 14440.9 14479.0 14561.3 14566.7 14650.1 6185.4 6293.6 6316.4 6338.0 6341.0 856.7 946.8 982.7 1059.7 1116.4 28281.7 28577.1 28937.7 29057.0 29194.6 988.3 1060.8 1062.8 1097.6 1192.6 14499.0 14632.9 14814.7 14824.6 14939.4 472896.0 477216.0 478972.0 482229.0 482913.0 57154.7 57368.4 57381.7 57500.0 57792.0 1322.9 1435.2 1436.5 1475.8 1476.8 23172.2 28423.4 28624.6 29310.0 29443.3 44960.3 45129.0 45356.0 45534.1 45593.1 339491.0 340514.0 341287.0 341396.0 342829.0 27995.9 31803.0 32720.5 32745.8 32813.2 39679.2 40440.0 40613.8 40729.6 41841.0 28748.7 33555.5 33674.5 34621.0 35079.6 28816.4 31501.5 33228.0 33350.5 33969.7 34863.3 35049.6 35871.3 35909.8 36000.0 30186.2 30863.8 30879.4 31104.5 31719.4 23452.8 23660.8 23733.9 23811.2 24212.8 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32295.47 Median:1485.35 stddev:92922.43 (6255.9%) stddev-sans-first:93152.07 02:21:18 INFO - PROCESS | 1668 | Values: 312.8 353.8 357.3 360.2 368.5 18926.6 19024.0 20078.9 20080.6 20129.6 18688.3 19547.2 19876.5 19888.4 19913.4 4919.0 5500.4 5837.8 5841.7 5852.9 4161.6 4367.3 4991.9 5809.6 6481.7 6336.6 6397.1 6406.5 6413.5 6428.5 6068.8 6390.1 6394.2 6394.3 6397.9 3722.8 3906.0 3911.4 5294.6 5523.8 23384.1 23512.8 24012.0 24759.0 24809.6 2116.9 2204.7 2217.5 2599.9 2657.9 13372.5 13698.2 14212.5 14397.0 14845.9 1606.6 1664.8 1770.2 1785.3 1786.1 95067.5 98450.0 98453.0 98751.5 100984.5 9960.9 10218.4 10614.3 10760.8 10765.7 13392.5 13424.5 13494.5 13524.4 13538.9 8103.6 8144.9 8169.3 8179.9 8259.5 8179.0 8195.3 8240.6 8316.0 8337.3 4229.0 4290.3 4301.7 4333.1 4348.4 1518.2 1786.7 1792.5 1793.4 1794.1 786.3 921.1 944.8 953.7 1047.6 18345.0 18823.8 18833.0 18980.8 19369.4 932.9 934.4 989.1 1016.9 1033.0 10158.2 10295.5 10403.1 10462.9 10468.8 550575.0 556130.0 562562.0 563707.0 566970.0 93092.0 112999.0 115760.8 116047.4 117137.0 918.1 952.3 954.4 965.6 966.9 14396.6 17033.0 17632.1 17791.9 17804.2 38932.6 48235.6 49914.0 50497.7 52128.0 61778.0 72208.6 72294.0 72748.3 74355.7 7486.6 7514.7 7523.7 7691.7 7755.6 10889.8 12156.1 12357.7 12461.7 12597.9 10444.8 10531.4 10577.2 10842.5 10868.8 10288.2 10467.1 10510.5 10550.0 10946.7 10422.7 10663.3 10836.0 10900.1 10902.5 7452.4 7632.7 7753.1 7853.5 7899.6 8110.1 10041.8 10471.2 10900.4 10910.6 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:6046.12 Median:5032.95 stddev:3169.21 (63.0%) stddev-sans-first:3160.10 02:21:18 INFO - PROCESS | 1668 | Values: 1551.8 1573.7 1833.6 1941.2 1975.2 8749.1 8826.3 8933.4 8961.7 8969.5 7863.8 8052.8 8515.7 8702.3 8797.6 2405.7 2491.9 2494.4 2495.1 2497.1 2181.8 2317.6 2363.2 2411.8 2415.3 2199.3 2427.3 2480.4 2483.6 2484.1 2441.0 2455.9 2456.7 2476.3 2479.1 1958.6 2311.5 2343.8 2346.2 2366.3 8799.6 8911.0 8912.8 8916.9 8926.6 5414.5 5600.8 5623.9 5628.7 5634.2 3547.7 3644.3 3664.8 3676.8 3687.2 1046.0 1055.0 1056.8 1065.1 1076.3 10238.3 12148.2 12193.3 12196.3 12227.4 4802.8 4849.7 4937.0 4947.2 4951.4 10194.6 10203.4 10205.8 10210.6 10220.2 5481.7 5544.6 5567.7 5577.8 5590.9 4977.2 5001.6 5005.0 5060.9 5068.4 3891.7 3922.9 3972.9 3975.0 3976.8 1090.5 1196.6 1250.8 1262.9 1330.4 1005.7 1026.3 1113.0 1262.7 1376.5 8018.5 8027.4 8111.8 8117.5 8128.8 1175.5 1178.3 1180.8 1207.6 1208.3 6128.4 6242.1 6243.7 6254.0 6259.4 10075.2 10491.8 10491.9 10567.0 10585.0 10171.5 10408.8 10430.5 10450.8 10459.7 8127.3 8256.8 8265.6 8272.7 8341.4 7938.4 7990.0 8004.2 8134.4 8251.4 8606.8 9576.0 9670.2 9735.8 9879.6 9746.8 9866.2 10023.1 10072.6 10186.9 7534.8 7540.0 7557.5 7636.3 7670.5 8202.8 8214.4 8256.5 8290.6 8321.4 6172.2 7353.9 7487.7 7629.4 7638.0 7175.9 7194.0 7237.5 7268.2 7274.3 6592.0 7554.0 7648.5 7678.9 7710.0 6642.1 6734.9 6736.3 6742.9 6756.1 6878.5 7091.8 7095.3 7113.7 7133.1 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:5608.11 Median:6420.08 stddev:1815.24 (28.3%) stddev-sans-first:1775.27 02:21:18 INFO - PROCESS | 1668 | Values: 252.4 321.7 322.1 328.4 328.9 6366.9 6492.4 6532.2 6562.2 6641.7 6430.3 6472.5 6491.3 6521.4 6531.9 4577.4 4689.0 4703.3 4805.3 4829.4 3788.7 4800.6 4813.5 4816.1 4818.7 4767.4 4768.7 4776.4 4785.5 4791.9 4530.2 4603.7 4606.9 4657.3 4771.0 3450.9 3953.6 4018.8 4029.1 4030.0 6151.6 6182.9 6191.5 6208.9 6236.2 5480.7 5496.2 5496.3 5502.8 5503.5 6818.5 6819.0 6820.7 6833.3 6834.3 3551.6 4289.6 4437.3 4439.4 4466.8 7127.9 7169.6 7249.0 7252.7 7270.9 4558.8 4559.4 4560.4 4572.8 4578.7 3815.6 4600.3 4609.3 4621.1 4627.1 4708.8 5281.9 5490.3 5514.4 5529.2 5977.0 6679.5 6913.8 6959.5 6965.9 1371.8 1579.7 1582.0 1592.3 1601.4 1015.8 1018.7 1035.4 1039.5 1039.6 6051.4 6186.7 6291.6 6335.7 6510.8 6497.6 6717.6 7212.2 7223.7 7231.2 6400.8 6415.6 6424.5 6425.4 6453.7 3764.2 3814.7 3825.8 3831.9 3840.2 7267.1 7452.4 7526.0 7535.3 7572.5 6488.4 7137.4 7441.9 7482.7 7517.3 6056.5 7525.1 7527.3 7543.5 7547.8 7166.5 7183.5 7189.2 7193.2 7222.3 6847.6 7091.3 7108.1 7115.1 7120.5 7469.7 7517.5 7518.2 7533.9 7537.4 4564.8 4567.9 4568.3 4581.0 4591.6 7153.9 7157.5 7180.6 7181.7 7181.8 5640.5 6584.4 6764.8 6837.1 6908.0 6762.9 6770.3 6796.0 6797.3 6808.7 6684.7 6738.4 6759.0 6761.8 6780.3 6924.5 6925.4 6926.0 6927.3 6937.4 5462.9 6535.9 6698.2 6715.6 6781.8 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:16777.51 Median:31794.69 stddev:22953.61 (72.2%) stddev-sans-first:22986.26 02:21:18 INFO - PROCESS | 1668 | Values: 701.4 754.1 758.8 759.6 808.5 14945.8 15088.2 15136.8 15145.2 15209.3 13662.6 14391.4 14409.5 14421.4 14433.7 740.2 755.4 898.3 914.1 915.3 923.2 924.3 925.7 928.4 930.5 961.8 968.1 969.5 969.9 971.2 774.8 956.7 958.7 974.3 977.1 688.4 711.5 726.1 728.0 728.4 14824.9 14860.5 14879.6 14899.5 14902.3 10751.4 12451.2 12536.9 12546.2 12909.7 8282.3 9862.6 9885.4 10297.6 10776.4 3450.9 3510.5 3515.4 3530.3 3617.5 71997.0 72057.0 72342.6 72393.0 72627.0 9271.2 9361.3 9473.1 9587.8 9757.8 21379.5 21391.8 21412.7 21413.0 21435.2 7160.7 7399.2 7419.4 7599.3 7600.5 3372.0 4036.2 4100.6 4178.3 4181.5 3075.5 3553.2 3594.2 3595.5 3603.1 571.1 629.6 641.2 644.3 645.0 488.6 528.2 573.9 602.1 602.6 7967.9 8220.5 8282.2 8302.0 8350.1 513.0 566.5 588.8 592.5 620.3 3802.3 3815.4 3832.8 3874.3 3999.4 81774.0 82048.2 83295.6 84545.0 84628.7 70438.0 70659.3 70706.6 71324.9 71774.0 62959.7 63316.7 63462.0 64779.7 64789.4 7565.2 7575.5 7794.8 7796.4 7868.4 41638.0 42802.4 44053.8 45205.0 46452.5 51434.7 53631.7 61252.7 62046.1 62242.0 10071.2 10182.8 10224.5 10245.6 10443.9 10702.8 10714.8 10722.7 10726.5 10828.4 10066.6 10086.3 10130.2 10206.3 10514.7 10071.3 10132.2 10185.3 10430.3 10558.5 9928.0 9960.7 9970.2 10217.7 10272.9 8641.4 8652.7 8900.4 8963.1 8980.6 8665.4 8752.8 8766.0 8769.3 8942.6 02:21:18 INFO - PROCESS | 1668 | -------- Summary: end -------- 02:21:18 INFO - PROCESS | 1668 | 02:21:18 INFO - TEST-INFO | 1668: exit 0 02:21:19 INFO - TEST-OK | dromaeo_css | took 1112371ms 02:21:19 INFO - TEST-START | kraken 02:21:19 INFO - operating with platform_type : mac_ 02:21:19 INFO - Initialising browser for kraken test... 02:21:19 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpQA4csK/profile http://localhost:49279/getInfo.html) 02:21:21 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 02:21:21 INFO - PROCESS | 1673 | colorDepth:24 02:21:21 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 02:21:21 INFO - PROCESS | 1673 | __metrics 02:21:21 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:21:21 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:21:21 INFO - TEST-INFO | 1673: exit 0 02:21:21 INFO - Browser initialized. 02:21:21 INFO - Running cycle 1/1 for kraken test... 02:21:21 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/tmpQA4csK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:33 INFO - PROCESS | 1675 | RSS: Main: 235974656 02:21:33 INFO - PROCESS | 1675 | 02:21:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 02:21:37 INFO - PROCESS | 1675 | RSS: Main: 281743360 02:21:37 INFO - PROCESS | 1675 | 02:21:39 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 02:21:40 INFO - PROCESS | 1675 | RSS: Main: 292896768 02:21:40 INFO - PROCESS | 1675 | 02:21:43 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 02:21:44 INFO - PROCESS | 1675 | RSS: Main: 278962176 02:21:44 INFO - PROCESS | 1675 | 02:21:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 02:21:46 INFO - PROCESS | 1675 | RSS: Main: 281911296 02:21:46 INFO - PROCESS | 1675 | 02:21:48 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:21:49 INFO - PROCESS | 1675 | RSS: Main: 283176960 02:21:49 INFO - PROCESS | 1675 | 02:21:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 02:21:52 INFO - PROCESS | 1675 | RSS: Main: 283983872 02:21:52 INFO - PROCESS | 1675 | 02:21:55 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 02:21:56 INFO - PROCESS | 1675 | RSS: Main: 283123712 02:21:56 INFO - PROCESS | 1675 | 02:21:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 02:21:59 INFO - PROCESS | 1675 | RSS: Main: 283488256 02:21:59 INFO - PROCESS | 1675 | 02:22:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:22:01 INFO - PROCESS | 1675 | RSS: Main: 315064320 02:22:01 INFO - PROCESS | 1675 | 02:22:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:22:04 INFO - PROCESS | 1675 | RSS: Main: 315600896 02:22:04 INFO - PROCESS | 1675 | 02:22:06 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:22:06 INFO - PROCESS | 1675 | RSS: Main: 322519040 02:22:06 INFO - PROCESS | 1675 | 02:22:09 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:22:10 INFO - PROCESS | 1675 | RSS: Main: 323809280 02:22:10 INFO - PROCESS | 1675 | 02:22:12 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:22:13 INFO - PROCESS | 1675 | RSS: Main: 323764224 02:22:13 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 02:22:15 INFO - PROCESS | 1675 | RSS: Main: 386396160 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | __start_tp_report 02:22:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 02:22:15 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 02:22:15 INFO - PROCESS | 1675 | |i|pagename|runs| 02:22:15 INFO - PROCESS | 1675 | |0;ai-astar;117;154;158;111;109;111;118;112;110;110 02:22:15 INFO - PROCESS | 1675 | |1;audio-beat-detection;157;120;144;159;118;147;142;137;163;119 02:22:15 INFO - PROCESS | 1675 | |2;audio-dft;187;181;187;187;187;184;185;183;182;181 02:22:15 INFO - PROCESS | 1675 | |3;audio-fft;74;75;74;116;56;57;58;58;121;56 02:22:15 INFO - PROCESS | 1675 | |4;audio-oscillator;92;93;125;79;79;81;117;78;78;119 02:22:15 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;89;85;89;86;88;86;90;89;89;86 02:22:15 INFO - PROCESS | 1675 | |6;imaging-darkroom;96;95;95;95;95;95;96;95;95;94 02:22:15 INFO - PROCESS | 1675 | |7;imaging-desaturate;86;86;85;86;85;89;87;85;86;87 02:22:15 INFO - PROCESS | 1675 | |8;json-parse-financial;55;57;54;53;54;55;53;63;55;53 02:22:15 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;66;64;74;79;71;68;71;67;91;98 02:22:15 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;84;82;97;107;107;108;82;85;84 02:22:15 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;127;133;129;132;131;119;122;123;134;122 02:22:15 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;140;129;148;141;140;129;140;146;137;137 02:22:15 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;68;67;66;67;68;67;78;92;92;77 02:22:15 INFO - PROCESS | 1675 | __end_tp_report 02:22:15 INFO - PROCESS | 1675 | __start_cc_report 02:22:15 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1285 02:22:15 INFO - PROCESS | 1675 | __end_cc_report 02:22:15 INFO - PROCESS | 1675 | __startTimestamp1459848135261__endTimestamp 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | ------- Summary: start ------- 02:22:15 INFO - PROCESS | 1675 | Number of tests: 14 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:121.00 Median:114.50 stddev:18.71 (16.3%) stddev-sans-first:19.79 02:22:15 INFO - PROCESS | 1675 | Values: 117.0 154.0 158.0 111.0 109.0 111.0 118.0 112.0 110.0 110.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:145.50 stddev:16.93 (11.6%) stddev-sans-first:16.88 02:22:15 INFO - PROCESS | 1675 | Values: 157.0 120.0 144.0 159.0 118.0 147.0 142.0 137.0 163.0 119.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:184.40 Median:186.00 stddev:2.55 (1.4%) stddev-sans-first:2.52 02:22:15 INFO - PROCESS | 1675 | Values: 187.0 181.0 187.0 187.0 187.0 184.0 185.0 183.0 182.0 181.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:74.50 Median:58.00 stddev:24.54 (42.3%) stddev-sans-first:26.03 02:22:15 INFO - PROCESS | 1675 | Values: 74.0 75.0 74.0 116.0 56.0 57.0 58.0 58.0 121.0 56.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:19.01 (24.1%) stddev-sans-first:20.14 02:22:15 INFO - PROCESS | 1675 | Values: 92.0 93.0 125.0 79.0 79.0 81.0 117.0 78.0 78.0 119.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:89.00 stddev:1.77 (2.0%) stddev-sans-first:1.81 02:22:15 INFO - PROCESS | 1675 | Values: 89.0 85.0 89.0 86.0 88.0 86.0 90.0 89.0 89.0 86.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 02:22:15 INFO - PROCESS | 1675 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.30 02:22:15 INFO - PROCESS | 1675 | Values: 86.0 86.0 85.0 86.0 85.0 89.0 87.0 85.0 86.0 87.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:3.01 (5.5%) stddev-sans-first:3.19 02:22:15 INFO - PROCESS | 1675 | Values: 55.0 57.0 54.0 53.0 54.0 55.0 53.0 63.0 55.0 53.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:72.50 stddev:11.30 (15.6%) stddev-sans-first:11.52 02:22:15 INFO - PROCESS | 1675 | Values: 66.0 64.0 74.0 79.0 71.0 68.0 71.0 67.0 91.0 98.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:83.00 stddev:11.58 (14.0%) stddev-sans-first:11.73 02:22:15 INFO - PROCESS | 1675 | Values: 82.0 84.0 82.0 97.0 107.0 107.0 108.0 82.0 85.0 84.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:130.00 stddev:5.37 (4.1%) stddev-sans-first:5.70 02:22:15 INFO - PROCESS | 1675 | Values: 127.0 133.0 129.0 132.0 131.0 119.0 122.0 123.0 134.0 122.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.70 Median:140.00 stddev:6.18 (4.4%) stddev-sans-first:6.54 02:22:15 INFO - PROCESS | 1675 | Values: 140.0 129.0 148.0 141.0 140.0 129.0 140.0 146.0 137.0 137.0 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:72.50 stddev:10.30 (14.2%) stddev-sans-first:10.68 02:22:15 INFO - PROCESS | 1675 | Values: 68.0 67.0 66.0 67.0 68.0 67.0 78.0 92.0 92.0 77.0 02:22:15 INFO - PROCESS | 1675 | -------- Summary: end -------- 02:22:15 INFO - PROCESS | 1675 | 02:22:15 INFO - TEST-INFO | 1675: exit 0 02:22:15 INFO - TEST-OK | kraken | took 56854ms 02:22:15 INFO - SUITE-END | took 1169s 02:22:15 INFO - Completed test suite (00:19:29) 02:22:15 INFO - javascript benchmark 02:22:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3381.154711322169, 3392.338493993669, 3401.6258211596705, 3425.1265927188565, 3507.105688049547, 5547.140193270049, 5630.971845140779, 5638.718064096799, 5654.802081927133, 5668.461496157864, 5615.157726341051, 5695.145728140781, 5705.686187259699, 5710.971445142768, 5731.168980497825, 5094.210397388392, 5131.435542090367, 5158.793648254065, 5170.327857378536, 5173.5085166909275, 5223.843284701465, 5260.26356310115, 5273.34083239595, 5308.0710875596615, 5326.680399176043, 5118.33461649985, 5135.743212839343, 5234.97382513085, 5238.711870847102, 5272.894542109156, 5202.2456743771945, 5206.635535512516, 5215.139501982168, 5252.159654455307, 5288.894222115575, 5106.744662766884, 5161.793528258865, 5162.767675454614, 5188.377394712621, 5231.267622532849, 5503.7798488060425, 5629.802956896489, 5634.295713035871, 5636.013697602903, 5644.6613203207935, 6102.610439773209, 6209.813705588839, 6209.9068513972325, 6224.782132625382, 6231.376862313778, 5828.388019258002, 6264.686765661699, 6275.7489700411925, 6296.748130074791, 6308.842278943063, 5535.474129957647, 5663.773449062074, 5778.0, 5785.074388097884, 5791.073428251501, 6194.783182588588, 6280.654563999024, 6281.0, 6281.277653069956, 6301.905471417932, 6057.757689692363, 6084.39156084388, 6127.387261273837, 6154.907676384858, 6159.476444502178, 6107.541934354941, 6218.968905155445, 6265.154204182377, 6270.717817698214, 6292.8426789329715, 6116.969415152896, 6156.6921653917125, 6170.0, 6179.0422484514975, 6182.319944806068, 6192.164057852222, 6219.222597175353, 6221.4089661482085, 6232.407921247474, 6249.500039996789, 4776.808927642925, 4854.611631069506, 4860.149473842134, 4877.926831097537, 4912.582430493377, 4358.5205627380965, 4370.169667763115, 4389.363542286351, 4417.933730993974, 4442.533533978885, 5547.972260138674, 5604.943950560442, 5615.578831587647, 5726.341470730836, 5733.541316694655, 6161.7227224775, 6224.035274532454, 6244.219472565929, 6249.96875015622, 6263.937360626335, 5631.1271752878365, 5632.831015069554, 5653.886922261532, 5661.631993920382, 5681.0058239808695, 5217.608679349064, 5300.231466437345, 5311.0174617695075, 5338.332708411449, 5391.7034563099405, 6268.561200715906, 6276.278228003838, 6290.276618188876, 6294.3076261612105, 6297.055441683692, 6210.347913469202, 6244.937550624436, 6264.592801468072, 6269.49844012487, 6271.592346497463, 6182.072689096672, 6220.066989951543, 6273.74905003813, 6280.874382512416, 6290.528210384148, 6135.386461353829, 6143.232095988002, 6145.231846019247, 6153.6923153841235, 6170.413810687977, 6219.813405597839, 6241.282252541016, 6241.531885108726, 6242.65665388408, 6295.1186833842385, 5951.970240148771, 6026.186464827192, 6027.156198132177, 6028.2163318770035, 6111.449969502766, 6009.0, 6066.484348830222, 6082.2093127893095, 6088.543359248163, 6110.877782444238, 5884.970575147268, 5916.615419997686, 5923.08192230205, 5923.970380148072, 5925.585209035326, 5898.498627616529, 5933.3769954154195, 6020.187274717857, 6057.363976782374, 6074.362191969956, 5118.718470484159, 5988.850278743066, 5989.251343582052, 5991.071383935497, 5991.430814072656], "unit": "score", "name": "dojo.html", "value": 5674.403640513733}, {"lowerIsBetter": false, "replicates": [489.86283840524663, 574.9507149452251, 583.9722089123142, 618.8886000519906, 628.6291088257927, 30276.09171724849, 37743.622563774356, 37830.24339513215, 37961.81019094904, 38008.42987355188, 40067.19865602686, 40738.79630601843, 40756.38865417021, 41015.0, 41204.58795412045, 9415.811683766338, 9678.903210967906, 9721.902780972207, 9723.367981081206, 9732.65935692251, 9528.904710952906, 9684.370515916478, 9686.903130968705, 9694.903050969471, 9704.90295097047, 9538.523073846314, 9619.615215391412, 9700.951495242514, 9706.320557560974, 9727.610895564168, 9590.08894155054, 9656.324057315991, 9662.178714809215, 9671.661491847752, 9676.274279429072, 9494.95252523733, 9520.047995200493, 9660.661876834347, 9662.56518456671, 9662.806743865154, 37844.24311513782, 38181.809090954644, 38209.61790382089, 38222.61777382218, 38389.80805095957, 3253.544503769474, 3305.0415379539904, 3383.9830800846084, 3386.475096360068, 3819.4843696100947, 28073.43853122926, 28890.71109288922, 29042.709572904212, 29223.97716079927, 29250.414991700047, 2743.2181828178873, 2763.4196818668106, 2799.7060308667706, 2845.9715402845914, 2878.0502434196874, 489416.1058389406, 492737.53631231975, 494462.0, 494564.0, 494816.0, 43937.12125757467, 44594.777026114665, 44766.10467790626, 62420.37579624236, 62730.0, 43773.0, 43788.781056094514, 43805.56194438015, 44019.89950251205, 44038.0, 15337.6165595861, 15441.30514126867, 15444.382224710886, 15503.689926201638, 15506.379744810081, 10949.014588686898, 12116.333601651817, 12161.635150945485, 12163.0, 12165.330906800034, 14440.927795360956, 14478.986470947144, 14561.344739486749, 14566.708665826836, 14650.120992740469, 6185.402926576914, 6293.622382657055, 6316.431521163117, 6338.0, 6340.968295158495, 856.6573370651664, 946.7680418297424, 982.7150126463246, 1059.6609085092696, 1116.3971455413985, 28281.71718282832, 28577.096465430517, 28937.7106228935, 29057.0, 29194.562081568794, 988.2785566536324, 1060.8037513060108, 1062.8086944349936, 1097.5664612478026, 1192.5570060227049, 14499.0, 14632.853671463148, 14814.703705925822, 14824.555263342118, 14939.402423902922, 472896.0, 477216.0, 478972.0, 482229.0, 482913.0, 57154.71422642943, 57368.42631573631, 57381.71309143428, 57500.0, 57792.0, 1322.9338533073308, 1435.2106341512126, 1436.5115860607234, 1475.8450362711976, 1476.8227812662549, 23172.18897338585, 28423.43153136967, 28624.57063144096, 29310.0, 29443.263918402212, 44960.32559511675, 45129.0, 45356.0, 45534.08931821279, 45593.08813823639, 339491.0, 340514.0, 341287.0, 341395.9813415887, 342829.0, 27995.860020699765, 31803.0, 32720.509192361656, 32745.836270818494, 32813.17967050843, 39679.2064158721, 40440.0, 40613.79693101515, 40729.59270407258, 41841.0, 28748.712512874605, 33555.496667549516, 33674.49488257727, 34621.0, 35079.64920350764, 28816.42367152687, 31501.52747708832, 33228.0, 33350.499742503394, 33969.66030339665, 34863.30273394467, 35049.64950350566, 35871.28257434889, 35909.820450897576, 36000.0, 30186.24534386658, 30863.845680771454, 30879.382412352075, 31104.533431998992, 31719.365612687154, 23452.765472345058, 23660.763392365858, 23733.881330593238, 23811.166609168595, 24212.75787242105], "unit": "score", "name": "ext.html", "value": 18476.81376653356}, {"lowerIsBetter": false, "replicates": [312.7826160818232, 353.7735849056604, 357.2818634544565, 360.19855820798716, 368.4694040581562, 18926.62146757064, 19024.0, 20078.89960550197, 20080.59838803223, 20129.59740805183, 18688.345907893225, 19547.21811127553, 19876.50308742282, 19888.403347899588, 19913.40259792205, 4919.0, 5500.367457742361, 5837.766489340422, 5841.737121829507, 5852.912206316909, 4161.625453709165, 4367.301231802912, 4991.875203119933, 5809.622374545641, 6481.74073037078, 6336.5881217720935, 6397.136386587821, 6406.487481001509, 6413.4869210463285, 6428.453581445583, 6068.848278793043, 6390.073439351291, 6394.232692076934, 6394.264659564116, 6397.872042559146, 3722.7766334019775, 3906.0, 3911.4328422378594, 5294.602904782157, 5523.8066667666435, 23384.064637414653, 23512.76487235123, 24012.0, 24759.0, 24809.63547004914, 2116.904739286736, 2204.691343211952, 2217.4788924602703, 2599.922002339933, 2657.9202623921315, 13372.531961381304, 13698.178109313472, 14212.502562410265, 14396.992210545266, 14845.851541484662, 1606.598350412397, 1664.8085470170963, 1770.1503278426428, 1785.3394244129624, 1786.0980204996524, 95067.52466237693, 98450.0, 98453.0, 98751.50624246904, 100984.49507752415, 9960.850587241197, 10218.386896786216, 10614.25700200994, 10760.784784304271, 10765.677029689123, 13392.531261405804, 13424.463021479227, 13494.52769153075, 13524.391402386917, 13538.93230533841, 8103.554304513191, 8144.918550814416, 8169.2647661710735, 8179.877301840477, 8259.545724985184, 8179.0, 8195.303399211014, 8240.587970601446, 8315.95842020786, 8337.291330236876, 4228.957710422918, 4290.2706539888295, 4301.720388174758, 4333.133373325348, 4348.369486424451, 1518.2332921874383, 1786.7314206913238, 1792.4712209898112, 1793.4350679536165, 1794.0581194872536, 786.2844811221761, 921.0927236671873, 944.8252073366449, 953.7043516509904, 1047.5966752800227, 18345.0, 18823.835258945124, 18833.0, 18980.810191897905, 19369.4189174325, 932.8554074118523, 934.4299977014016, 989.124624707125, 1016.9237307201842, 1033.0289527843802, 10158.238132140119, 10295.485225738683, 10403.063724264852, 10462.901395353378, 10468.790624187473, 550575.0, 556130.0, 562562.0, 563707.0, 566970.0, 93092.0, 112999.0, 115760.84239157669, 116047.41976290065, 117137.0, 918.1140199707181, 952.2667545989688, 954.4321128928276, 965.6234068713208, 966.9468179250209, 14396.55215316205, 17033.0, 17632.118394080502, 17791.932484050998, 17804.198811053273, 38932.6106738929, 48235.55293341205, 49914.0, 50497.747511262205, 52128.0, 61778.0, 72208.63895680488, 72294.0, 72748.27251727415, 74355.7055368079, 7486.5508069516, 7514.736984205527, 7523.7366692165515, 7691.692332306645, 7755.573443460664, 10889.78220435571, 12156.088293377856, 12357.691057723268, 12461.688457788629, 12597.93701031489, 10444.791104178026, 10531.368117912949, 10577.206709496664, 10842.457877105955, 10868.836967445653, 10288.176945844165, 10467.057964783206, 10510.527026283988, 10549.997750213717, 10946.726331841768, 10422.687319380431, 10663.253572249869, 10836.0, 10900.07349375312, 10902.50938707776, 7452.366548843409, 7632.656530456254, 7753.147153812964, 7853.45025848208, 7899.565523896241, 8110.06734225548, 10041.849372259276, 10471.21465890046, 10900.400477973788, 10910.61812836547], "unit": "score", "name": "jquery.html", "value": 9116.488246419649}, {"lowerIsBetter": false, "replicates": [1551.774992626069, 1573.7245981953156, 1833.6332733453305, 1941.2041063164106, 1975.1803001754272, 8749.081346458617, 8826.338024648161, 8933.4193277437, 8961.686340978067, 8969.506677132755, 7863.8034049148655, 8052.758417247477, 8515.701950431736, 8702.260307873838, 8797.648094076229, 2405.699287589047, 2491.9377015574664, 2494.4138127540014, 2495.126705653016, 2497.12600589793, 2181.825453963679, 2317.617593097137, 2363.243761996162, 2411.807055435561, 2415.323709361373, 2199.25225423356, 2427.332483567024, 2480.441900572375, 2483.6026235802274, 2484.1429706751233, 2440.987795061022, 2455.852648841066, 2456.7051953765485, 2476.2695004973575, 2479.095130277454, 1958.6278607064612, 2311.5492478966607, 2343.7773411525877, 2346.21401830387, 2366.337425520857, 8799.648014079428, 8911.0, 8912.821743565093, 8916.910830891673, 8926.642934282685, 5414.485623865727, 5600.775968961237, 5623.887522249532, 5628.690422026787, 5634.211210430543, 3547.6807087362004, 3644.2529281497227, 3664.76179048361, 3676.8345424455965, 3687.1519550503267, 1045.968620941373, 1054.9525271362807, 1056.7675111475462, 1065.0999905080196, 1076.2896488317672, 10238.283320167591, 12148.21036632616, 12193.329366884818, 12196.329201893892, 12227.388630568525, 4802.807887684523, 4849.660523763373, 4936.950630493649, 4947.1837146871085, 4951.430585482643, 10194.592216311414, 10203.438810865473, 10205.795884082278, 10210.591576336863, 10220.233482488844, 5481.698506582176, 5544.556435485151, 5567.693776842231, 5577.832665020056, 5590.888182236333, 4977.228529577921, 5001.624878134082, 5004.974975125101, 5060.924086138711, 5068.366454193226, 3891.747036442622, 3922.9215415692097, 3972.880813575597, 3974.9801250994137, 3976.8011599420493, 1090.5038207615673, 1196.5931583261734, 1250.7936190528642, 1262.9431675574622, 1330.4212667489674, 1005.6731562242301, 1026.2610920137488, 1112.9888701113048, 1262.6906407930117, 1376.5250988408982, 8018.4787988780545, 8027.438079334391, 8111.797205069921, 8117.472364296302, 8128.796780080427, 1175.488662431845, 1178.269472926791, 1180.7579446213506, 1207.6075275535486, 1208.3112625803208, 6128.417800308964, 6242.09489624002, 6243.719032643542, 6254.0, 6259.405356491126, 10075.19398448137, 10491.842622360671, 10491.895081049244, 10567.048965593134, 10585.0, 10171.54228059739, 10408.843867341995, 10430.478476076165, 10450.790984180274, 10459.686209413578, 8127.268545830903, 8256.844041834149, 8265.586720663943, 8272.710455134162, 8341.374396920255, 7938.404619653665, 7989.960050199712, 8004.239597238253, 8134.430589858653, 8251.422400431911, 8606.78483037929, 9576.042395760369, 9670.178034867115, 9735.756606084622, 9879.555420005972, 9746.805063898824, 9866.16137628281, 10023.148032417326, 10072.647457338959, 10186.949065254626, 7534.811629709301, 7539.962300188464, 7557.5465472071855, 7636.31273185416, 7670.463067585216, 8202.753917382488, 8214.383921205814, 8256.463329883538, 8290.626921788413, 8321.417500774887, 6172.22847144107, 7353.852922941618, 7487.700491980478, 7629.351505122127, 7637.961810191136, 7175.928240717735, 7193.964030179815, 7237.529560578546, 7268.200497945328, 7274.30894065063, 6591.96704016496, 7553.962230188814, 7648.502847314907, 7678.884816727642, 7709.961450192937, 6642.103316052271, 6734.9326506734305, 6736.259011508828, 6742.898856517058, 6756.121704178426, 6878.518503704893, 7091.787246382617, 7095.290470952863, 7113.679884405111, 7133.144022717307], "unit": "score", "name": "mootools.html", "value": 4928.708670176491}, {"lowerIsBetter": false, "replicates": [252.36026672385506, 321.695997282568, 322.12382320089347, 328.43837038663867, 328.9194147433879, 6366.936330636692, 6492.448141907944, 6532.183477065367, 6562.212534495867, 6641.667916604175, 6430.260520040197, 6472.51456140789, 6491.2859585445685, 6521.445677117451, 6531.869362612745, 4577.359169716243, 4688.953110468903, 4703.270992996091, 4805.3032310315075, 4829.4446138693975, 3788.677962373202, 4800.591949684281, 4813.518648135194, 4816.109019831342, 4818.662693611449, 4767.356406885061, 4768.713877167381, 4776.426828780551, 4785.521447855222, 4791.928121078186, 4530.184566777995, 4603.654725895538, 4606.884827879297, 4657.324687920266, 4771.045790841828, 3450.9482357764405, 3953.584873588289, 4018.799060046986, 4029.073313137995, 4029.959700403017, 6151.569390142692, 6182.876342473125, 6191.473724733403, 6208.875822483525, 6236.220472440945, 5480.725963701839, 5496.1755736639425, 5496.340439147288, 5502.8349149525575, 5503.532199762985, 6818.4886133540185, 6819.045333653293, 6820.727170913157, 6833.3166683331765, 6834.266293482597, 3551.6093229744706, 4289.571042895716, 4437.29003359461, 4439.400680908101, 4466.754328511931, 7127.893081603728, 7169.5698258104685, 7249.021382113453, 7252.70989160433, 7270.9093635954505, 4558.840440584564, 4559.38448309474, 4560.361549383089, 4572.81708731647, 4578.679492435497, 3815.5802861685193, 4600.263957766741, 4609.331646911179, 4621.1219868224925, 4627.1439783640135, 4708.764561771898, 5281.9207711884355, 5490.3411590609385, 5514.448555144534, 5529.170624406372, 5976.970115149484, 6679.532432729759, 6913.75801846933, 6959.478039147084, 6965.895511567331, 1371.7736573465465, 1579.7393430083907, 1581.9604509887345, 1592.33122088723, 1601.391471240921, 1015.8019186258608, 1018.7351288665001, 1035.4460363705532, 1039.5322105052755, 1039.604950118965, 6051.364606716319, 6186.721597528122, 6291.55959082869, 6335.65153916539, 6510.837229069217, 6497.642629655415, 6717.596944183365, 7212.242714515005, 7223.674934627954, 7231.168415632164, 6400.839979000562, 6415.647139407284, 6424.518161137933, 6425.3574642536305, 6453.741850326029, 3764.153065560282, 3814.675752561008, 3825.8087095645105, 3831.885043448701, 3840.1935593525673, 7267.127944646676, 7452.403807695371, 7525.962370188114, 7535.284148005931, 7572.4699271050495, 6488.416042556192, 7137.4290056795335, 7441.925580744231, 7482.6632801524065, 7517.323440890346, 6056.485198758155, 7525.134609519756, 7527.2849079337375, 7543.547387156678, 7547.811304717426, 7166.462515311268, 7183.461240406886, 7189.245129261352, 7193.172785129568, 7222.349988501061, 6847.589144651337, 7091.326323999212, 7108.111486064242, 7115.146182458138, 7120.53716508446, 7469.701211951461, 7517.473776835569, 7518.248175182438, 7533.886991695239, 7537.434692398202, 4564.8174073038035, 4567.908641827211, 4568.269076947672, 4581.0, 4591.609713174284, 7153.928460715326, 7157.463190260647, 7180.569165849857, 7181.712731490891, 7181.784546463615, 5640.548756099584, 6584.407403333723, 6764.830879228059, 6837.1111755471475, 6907.998340240738, 6762.86474270502, 6770.289119642367, 6795.966020169867, 6797.28628494001, 6808.727650894107, 6684.699188536625, 6738.35985581369, 6758.966205168943, 6761.763338283136, 6780.25417204117, 6924.515283930278, 6925.411340035952, 6926.0, 6927.307269273032, 6937.445004399737, 5462.945370546244, 6535.869282614226, 6698.229703583956, 6715.5970641759695, 6781.762638307636], "unit": "score", "name": "prototype.html", "value": 4996.197770593491}, {"lowerIsBetter": false, "replicates": [701.4003027411563, 754.0950858969235, 758.8482303539294, 759.5556599389357, 808.4906508899394, 14945.775813362794, 15088.17015064171, 15136.848631513682, 15145.242737863104, 15209.315580798877, 13662.590122296348, 14391.424343026292, 14409.495667651634, 14421.423143074291, 14433.711325773478, 740.1857956248111, 755.3805879179075, 898.3127907151035, 914.1498406481969, 915.3180880244228, 923.224491427201, 924.2652091587204, 925.6991477769718, 928.3640706116298, 930.50683137937, 961.8172547216006, 968.1238479176321, 969.5394687523406, 969.8933117357085, 971.1599466461495, 774.802425381527, 956.7273327101777, 958.6644674363987, 974.3228456222928, 977.1352353167426, 688.4079691465336, 711.5268346549539, 726.0525014855612, 727.9745208917662, 728.351766927435, 14824.925875370662, 14860.479883204143, 14879.553613391616, 14899.47851825181, 14902.329395177243, 10751.395107310216, 12451.190672606343, 12536.937315313457, 12546.247225166428, 12909.67725806853, 8282.337413006944, 9862.556184971694, 9885.357451765612, 10297.639582614647, 10776.353418794897, 3450.87921922734, 3510.473428985647, 3515.402381595135, 3530.258645684409, 3617.5478065241846, 71997.0, 72057.0, 72342.63828680875, 72393.0, 72627.0, 9271.150274627584, 9361.344705870524, 9473.147416732527, 9587.760305992266, 9757.756056098655, 21379.46551336229, 21391.78608213929, 21412.678809817866, 21413.0, 21435.249766258105, 7160.749373771893, 7399.223081576464, 7419.369353605004, 7599.278068583476, 7600.50596711212, 3371.9662803371652, 4036.17202511838, 4100.5899410059355, 4178.331466965271, 4181.519125300569, 3075.4617941860533, 3553.200529880808, 3594.2272411431145, 3595.478655594924, 3603.1172362770762, 571.0988180045359, 629.6348118091588, 641.2369280556217, 644.2751904107879, 645.0356716708551, 488.64084897600236, 528.2074703627987, 573.8938296415093, 602.0517684646699, 602.6474512410201, 7967.880481792778, 8220.464730539235, 8282.213189746964, 8302.003759548772, 8350.08149103598, 513.0278122956976, 566.498648695907, 588.8174665853599, 592.5496622566794, 620.3424370167637, 3802.2775672622115, 3815.3895376740143, 3832.7700337979254, 3874.341361968472, 3999.420084087791, 81774.0, 82048.17951820524, 83295.583522082, 84545.0, 84628.73056904151, 70438.0, 70659.29340706527, 70706.58586828235, 71324.93012604814, 71774.0, 62959.74080518364, 63316.68341658262, 63462.0, 64779.676101620134, 64789.352106478334, 7565.167831538636, 7575.469717119749, 7794.844103117793, 7796.415268854972, 7868.3727987583125, 41638.0, 42802.35796462993, 44053.77973110242, 45205.0, 46452.53547464482, 51434.74282628563, 53631.731841340545, 61252.69373653103, 62046.069308961305, 62242.0, 10071.19430445548, 10182.847257291294, 10224.53989570486, 10245.641402550875, 10443.895561044292, 10702.839457408301, 10714.839277411002, 10722.73193170177, 10726.463676816284, 10828.404437755999, 10066.597336106766, 10086.29395942277, 10130.240231982483, 10206.336588121749, 10514.737131571466, 10071.34536255141, 10132.240081994027, 10185.33795303303, 10430.322029068086, 10558.472076396303, 9928.0, 9960.701178964642, 9970.152537034142, 10217.74455638615, 10272.948635256776, 8641.436315027888, 8652.653893844175, 8900.42147260426, 8963.05887881789, 8980.595873185854, 8665.43674661145, 8752.78118047054, 8765.956170219108, 8769.254613357682, 8942.552872356226], "unit": "score", "name": "yui.html", "value": 6611.557107942487}], "name": "dromaeo_css", "value": 7334.109982372764}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 154.0, 158.0, 111.0, 109.0, 111.0, 118.0, 112.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 121.0}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 144.0, 159.0, 118.0, 147.0, 142.0, 137.0, 163.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 140.6}, {"lowerIsBetter": true, "replicates": [187.0, 181.0, 187.0, 187.0, 187.0, 184.0, 185.0, 183.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.4}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 74.0, 116.0, 56.0, 57.0, 58.0, 58.0, 121.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.5}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 125.0, 79.0, 79.0, 81.0, 117.0, 78.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 86.0, 90.0, 89.0, 89.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 95.1}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 85.0, 86.0, 85.0, 89.0, 87.0, 85.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.2}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 54.0, 53.0, 54.0, 55.0, 53.0, 63.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 74.0, 79.0, 71.0, 68.0, 71.0, 67.0, 91.0, 98.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 74.9}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 82.0, 97.0, 107.0, 107.0, 108.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 91.8}, {"lowerIsBetter": true, "replicates": [127.0, 133.0, 129.0, 132.0, 131.0, 119.0, 122.0, 123.0, 134.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [140.0, 129.0, 148.0, 141.0, 140.0, 129.0, 140.0, 146.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 67.0, 68.0, 67.0, 78.0, 92.0, 92.0, 77.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 74.2}], "name": "kraken", "value": 1445.6000000000004}]} 02:22:15 INFO - Return code: 0 02:22:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:22:16 ERROR - # TBPL SUCCESS # 02:22:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:22:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:22:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:22:16 INFO - 2016-04-05 02:22:16.062 screenresolution[1679:9741] starting screenresolution argv=screenresolution get 02:22:16 INFO - 2016-04-05 02:22:16.065 screenresolution[1679:9741] Display 0: 1600x1200x32@60 02:22:16 INFO - 2016-04-05 02:22:16.071 screenresolution[1680:9744] starting screenresolution argv=screenresolution list 02:22:16 INFO - Available Modes on Display 0 02:22:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:22:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:22:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:22:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:22:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:22:16 INFO - Intel Iris: 02:22:16 INFO - Chipset Model: Intel Iris 02:22:16 INFO - Type: GPU 02:22:16 INFO - Bus: Built-In 02:22:16 INFO - VRAM (Dynamic, Max): 1536 MB 02:22:16 INFO - Vendor: Intel (0x8086) 02:22:16 INFO - Device ID: 0x0a2e 02:22:16 INFO - Revision ID: 0x0009 02:22:16 INFO - Displays: 02:22:16 INFO - Display: 02:22:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:22:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:22:16 INFO - Display Serial Number: 1600x1200 60 02:22:16 INFO - Main Display: Yes 02:22:16 INFO - Mirror: Off 02:22:16 INFO - Online: Yes 02:22:16 INFO - Rotation: Supported 02:22:16 INFO - Return code: 0 02:22:16 INFO - Running post-action listener: _resource_record_post_action 02:22:16 INFO - Running post-run listener: _resource_record_post_run 02:22:17 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 32108032; Write bytes: 702672896; Read time: 317; Write time: 2005 02:22:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392655360; Write bytes: 386276352; Read time: 29789; Write time: 692 02:22:17 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 30322176; Write bytes: 297911296; Read time: 298; Write time: 1272 02:22:17 INFO - Running post-run listener: _upload_blobber_files 02:22:17 INFO - Blob upload gear active. 02:22:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:22:17 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:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:22:17 INFO - (blobuploader) - INFO - Open directory for files ... 02:22:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:22:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:22:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:19 INFO - (blobuploader) - INFO - Done attempting. 02:22:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:22:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:22:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:22:20 INFO - (blobuploader) - INFO - Done attempting. 02:22:20 INFO - (blobuploader) - INFO - Iteration through files over. 02:22:20 INFO - Return code: 0 02:22:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:22:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:22:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4c265fd5ac4da99da46330cae0a2630acffe2ad02b5e6844107efc7fcc04bf9c871e33acc3aa870cf00bf32a86119fad322eacc6b137db52ba4315ac100cdba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ca39e21519db62a8c7e02a12ed9752b0867fecbc256095e5d34f8370184030dbdef54af74df24b47d85b0d8fdadfad5f5d1a2c921918b72b75631a494130f6"} 02:22:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:22:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:22:20 INFO - Contents: 02:22:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4c265fd5ac4da99da46330cae0a2630acffe2ad02b5e6844107efc7fcc04bf9c871e33acc3aa870cf00bf32a86119fad322eacc6b137db52ba4315ac100cdba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ca39e21519db62a8c7e02a12ed9752b0867fecbc256095e5d34f8370184030dbdef54af74df24b47d85b0d8fdadfad5f5d1a2c921918b72b75631a494130f6"} 02:22:20 INFO - Running post-run listener: copy_logs_to_upload_dir 02:22:20 INFO - Copying logs to upload dir... 02:22:20 INFO - mkdir: /builds/slave/test/build/upload/logs 02:22:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.511462 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-05 02:22:20.686140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 02:22:20.689212) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4c265fd5ac4da99da46330cae0a2630acffe2ad02b5e6844107efc7fcc04bf9c871e33acc3aa870cf00bf32a86119fad322eacc6b137db52ba4315ac100cdba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ca39e21519db62a8c7e02a12ed9752b0867fecbc256095e5d34f8370184030dbdef54af74df24b47d85b0d8fdadfad5f5d1a2c921918b72b75631a494130f6"} build_url:https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/W6KB_s1cScqOdyf7C4fj-w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e4c265fd5ac4da99da46330cae0a2630acffe2ad02b5e6844107efc7fcc04bf9c871e33acc3aa870cf00bf32a86119fad322eacc6b137db52ba4315ac100cdba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62ca39e21519db62a8c7e02a12ed9752b0867fecbc256095e5d34f8370184030dbdef54af74df24b47d85b0d8fdadfad5f5d1a2c921918b72b75631a494130f6"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 02:22:20.754707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:22:20.755011) ========= 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.wgXwQBYkxp/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.bV6SGP3AT2/Listeners TMPDIR=/var/folders/rv/24r_1zwd7p5g3k569h6ts1cw00000w/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.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 02:22:20.804453) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 02:22:20.804725) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 02:22:20.805097) ========= ========= Total master_lag: 1.09 =========