builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0052 starttime: 1457521806.08 results: success (0) buildid: 20160308030418 builduid: 52f869aa1dd9435989dd476b4b9f0811 revision: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:06.100854) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:06.101313) ========= ========= Started set props: basedir (results: 0, elapsed: 18 secs) (at 2016-03-09 03:10:06.101602) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005535 basedir: '/builds/slave/test' ========= master_lag: 18.55 ========= ========= Finished set props: basedir (results: 0, elapsed: 18 secs) (at 2016-03-09 03:10:24.658912) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-09 03:10:24.659232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 18 secs) (at 2016-03-09 03:10:42.807814) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 03:10:42.808177) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005480 ========= master_lag: 2.60 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 03:10:45.417840) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:45.418123) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:45.418478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 03:10:45.418772) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-09 03:10:45-- 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% 30.9M=0s 2016-03-09 03:10:45 (30.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193294 ========= master_lag: 0.88 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-09 03:10:46.495667) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 03:10:46.495974) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.020193 ========= master_lag: 2.31 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-09 03:10:48.829317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-09 03:10:48.829680) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --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 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-09 03:10:49,243 truncating revision to first 12 chars 2016-03-09 03:10:49,243 Setting DEBUG logging. 2016-03-09 03:10:49,243 attempt 1/10 2016-03-09 03:10:49,243 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05c087337043?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-09 03:10:50,914 unpacking tar archive at: mozilla-central-05c087337043/testing/mozharness/ program finished with exit code 0 elapsedTime=1.914822 ========= master_lag: 1.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-03-09 03:10:51.907341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:51.907693) ========= echo 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'05c087337043dd8e71cc27bdb5b9d55fd00aaa26'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 program finished with exit code 0 elapsedTime=0.005179 script_repo_revision: '05c087337043dd8e71cc27bdb5b9d55fd00aaa26' ========= master_lag: 0.58 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:52.491624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:52.492007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-09 03:10:53.433276) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 4 secs) (at 2016-03-09 03:10:53.433693) ========= /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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:10:53 INFO - MultiFileLogger online at 20160309 03:10:53 in /builds/slave/test 03:10:53 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 03:10:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:10:53 INFO - {'append_to_log': False, 03:10:53 INFO - 'base_work_dir': '/builds/slave/test', 03:10:53 INFO - 'blob_upload_branch': 'Firefox', 03:10:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:10:53 INFO - 'branch': 'Firefox', 03:10:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:10:53 INFO - 'config_files': ('talos/mac_config.py',), 03:10:53 INFO - 'default_actions': ('clobber', 03:10:53 INFO - 'read-buildbot-config', 03:10:53 INFO - 'download-and-extract', 03:10:53 INFO - 'populate-webroot', 03:10:53 INFO - 'create-virtualenv', 03:10:53 INFO - 'install', 03:10:53 INFO - 'run-tests'), 03:10:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:10:53 INFO - 'download_minidump_stackwalk': True, 03:10:53 INFO - 'download_symbols': 'ondemand', 03:10:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:10:53 INFO - 'tooltool.py': '/tools/tooltool.py', 03:10:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:10:53 INFO - '/tools/misc-python/virtualenv.py')}, 03:10:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:10:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:10:53 INFO - 'installer_path': 'installer.exe', 03:10:53 INFO - 'log_level': 'info', 03:10:53 INFO - 'log_name': 'talos', 03:10:53 INFO - 'log_to_console': True, 03:10:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:10:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:10:53 INFO - 'opt_config_files': (), 03:10:53 INFO - 'pip_index': False, 03:10:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:53 INFO - 'cmd': ('bash', 03:10:53 INFO - '-c', 03:10:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:53 INFO - 'enabled': True, 03:10:53 INFO - 'halt_on_failure': False, 03:10:53 INFO - 'name': 'check_screen_resolution'},), 03:10:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:10:53 INFO - 'cmd': ('bash', 03:10:53 INFO - '-c', 03:10:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:10:53 INFO - 'enabled': True, 03:10:53 INFO - 'halt_on_failure': False, 03:10:53 INFO - 'name': 'check_screen_resolution'},), 03:10:53 INFO - 'run_cmd_checks_enabled': True, 03:10:53 INFO - 'sps_profile': False, 03:10:53 INFO - 'sps_profile_interval': 0, 03:10:53 INFO - 'suite': 'dromaeojs', 03:10:53 INFO - 'system_bits': '32', 03:10:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:10:53 INFO - 'title': 't-yosemite-r7-0052', 03:10:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:10:53 INFO - 'use_talos_json': True, 03:10:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:10:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:10:53 INFO - 'work_dir': 'build'} 03:10:53 INFO - ##### 03:10:53 INFO - ##### Running clobber step. 03:10:53 INFO - ##### 03:10:53 INFO - Running pre-action listener: _resource_record_pre_action 03:10:53 INFO - Running main action method: clobber 03:10:53 INFO - rmtree: /builds/slave/test/build 03:10:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:10:54 INFO - Running post-action listener: _resource_record_post_action 03:10:54 INFO - ##### 03:10:54 INFO - ##### Running read-buildbot-config step. 03:10:54 INFO - ##### 03:10:54 INFO - Running pre-action listener: _resource_record_pre_action 03:10:54 INFO - Running main action method: read_buildbot_config 03:10:54 INFO - Using buildbot properties: 03:10:54 INFO - { 03:10:54 INFO - "project": "", 03:10:54 INFO - "product": "firefox", 03:10:54 INFO - "script_repo_revision": "production", 03:10:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:10:54 INFO - "repository": "", 03:10:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:10:54 INFO - "buildid": "20160308030418", 03:10:54 INFO - "stage_platform": "macosx64", 03:10:54 INFO - "basedir": "/builds/slave/test", 03:10:54 INFO - "nightly_build": "True", 03:10:54 INFO - "buildnumber": 171, 03:10:54 INFO - "slavename": "t-yosemite-r7-0052", 03:10:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:10:54 INFO - "platform": "yosemite_r7", 03:10:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:10:54 INFO - "branch": "mozilla-central", 03:10:54 INFO - "repo_path": "mozilla-central", 03:10:54 INFO - "revision": "05c087337043dd8e71cc27bdb5b9d55fd00aaa26", 03:10:54 INFO - "pgo_build": "False", 03:10:54 INFO - "builduid": "52f869aa1dd9435989dd476b4b9f0811", 03:10:54 INFO - "slavebuilddir": "test" 03:10:54 INFO - } 03:10:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:10:54 INFO - Running post-action listener: _resource_record_post_action 03:10:54 INFO - ##### 03:10:54 INFO - ##### Running download-and-extract step. 03:10:54 INFO - ##### 03:10:54 INFO - Running pre-action listener: _resource_record_pre_action 03:10:54 INFO - Running main action method: download_and_extract 03:10:54 INFO - mkdir: /builds/slave/test/build/tests 03:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:10:54 INFO - https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:10:56 INFO - Downloaded 1277 bytes. 03:10:56 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:10:56 INFO - Using the following test package requirements: 03:10:56 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:10:56 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:10:56 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:10:56 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'jsshell-mac.zip'], 03:10:56 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:10:56 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:10:56 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:10:56 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:10:56 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:10:56 INFO - u'webapprt': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:10:56 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:10:56 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:10:56 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:10: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')]} 03:10:56 INFO - https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:10:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:10:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:10:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:10:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:10:57 INFO - Downloaded 17866525 bytes. 03:10:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:10:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:11:00 INFO - Return code: 0 03:11:00 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 03:11:00 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')]} 03:11:00 INFO - https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:11:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:11:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:11:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:11:01 INFO - Downloaded 17866525 bytes. 03:11:01 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'] 03:11:01 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 03:11:05 INFO - Return code: 0 03:11: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')]} 03:11:05 INFO - https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:11:06 INFO - Downloaded 10845161 bytes. 03:11:06 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'] 03:11:06 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 03:11:06 INFO - Return code: 0 03:11:06 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')]} 03:11:06 INFO - https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bXR48lozTVmIApf7GIRhJA/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 03:11:09 INFO - Downloaded 111117927 bytes. 03:11:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:11:09 INFO - mkdir: /builds/slave/test/properties 03:11:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:11:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:11:09 INFO - Contents: 03:11:09 INFO - build_url:https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:11:10 INFO - Running post-action listener: _resource_record_post_action 03:11:10 INFO - Running post-action listener: set_extra_try_arguments 03:11:10 INFO - ##### 03:11:10 INFO - ##### Running populate-webroot step. 03:11:10 INFO - ##### 03:11:10 INFO - Running pre-action listener: _resource_record_pre_action 03:11:10 INFO - Running main action method: populate_webroot 03:11:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:11:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:11:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:11:10 INFO - '--tppagecycles', 03:11:10 INFO - '7'], 03:11:10 INFO - 'tests': ['tsvgm']}}, 03:11:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:11:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:11:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:11:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:11:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:11:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'tests': ['damp', 'tps']}, 03:11:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['damp', 'tps']}, 03:11:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:11:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:11:10 INFO - 'other': {'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'other_l64': {'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'other_nol64': {'tests': ['a11yr', 03:11:10 INFO - 'ts_paint', 03:11:10 INFO - 'tpaint', 03:11:10 INFO - 'sessionrestore', 03:11:10 INFO - 'sessionrestore_no_auto_restore', 03:11:10 INFO - 'tabpaint']}, 03:11:10 INFO - 'svgr': {'tests': ['tsvgx', 03:11:10 INFO - 'tsvgr_opacity', 03:11:10 INFO - 'tart', 03:11:10 INFO - 'tscrollx', 03:11:10 INFO - 'cart']}, 03:11:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['tsvgx', 03:11:10 INFO - 'tsvgr_opacity', 03:11:10 INFO - 'tart', 03:11:10 INFO - 'tscrollx', 03:11:10 INFO - 'cart']}, 03:11:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'tests': ['tp5o']}, 03:11:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'talos_options': ['--e10s'], 03:11:10 INFO - 'tests': ['tp5o']}, 03:11:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'talos_options': ['--xperf_path', 03:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:10 INFO - 'tests': ['tp5n']}, 03:11:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:11:10 INFO - 'talos_options': ['--e10s', 03:11:10 INFO - '--xperf_path', 03:11:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:11:10 INFO - 'tests': ['tp5n']}}, 03:11:10 INFO - 'talos.zip': {'path': '', 03:11:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:11:10 INFO - Running post-action listener: _resource_record_post_action 03:11:10 INFO - ##### 03:11:10 INFO - ##### Running create-virtualenv step. 03:11:10 INFO - ##### 03:11:10 INFO - Running pre-action listener: _resource_record_pre_action 03:11:10 INFO - Running main action method: create_virtualenv 03:11:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:11:10 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 03:11:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:11:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:11:10 INFO - Using real prefix '/tools/python27' 03:11:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:11:11 INFO - Installing distribute.............................................................................................................................................................................................done. 03:11:14 INFO - Installing pip.................done. 03:11:14 INFO - Return code: 0 03:11:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:14 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:14 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 03:11:14 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 03:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:14 INFO - 'HOME': '/Users/cltbld', 03:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:14 INFO - 'LOGNAME': 'cltbld', 03:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:14 INFO - 'MOZ_NO_REMOTE': '1', 03:11:14 INFO - 'NO_EM_RESTART': '1', 03:11:14 INFO - 'PAGER': '/bin/cat', 03:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:14 INFO - 'PWD': '/builds/slave/test', 03:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:14 INFO - 'SHELL': '/bin/bash', 03:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:14 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:14 INFO - 'USER': 'cltbld', 03:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:14 INFO - 'XPC_FLAGS': '0x0', 03:11:14 INFO - 'XPC_SERVICE_NAME': '0', 03:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:14 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 03:11:14 INFO - Cleaning up... 03:11:14 INFO - Return code: 0 03:11:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:14 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:14 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 03:11:14 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 03:11:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:14 INFO - 'HOME': '/Users/cltbld', 03:11:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:14 INFO - 'LOGNAME': 'cltbld', 03:11:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:14 INFO - 'MOZ_NO_REMOTE': '1', 03:11:14 INFO - 'NO_EM_RESTART': '1', 03:11:14 INFO - 'PAGER': '/bin/cat', 03:11:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:14 INFO - 'PWD': '/builds/slave/test', 03:11:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:14 INFO - 'SHELL': '/bin/bash', 03:11:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:14 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:14 INFO - 'USER': 'cltbld', 03:11:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:14 INFO - 'XPC_FLAGS': '0x0', 03:11:14 INFO - 'XPC_SERVICE_NAME': '0', 03:11:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:14 INFO - Downloading/unpacking psutil>=0.7.1 03:11:14 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 03:11:14 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 03:11:14 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 03:11:14 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 03:11:14 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 03:11:14 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 03:11:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:11:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:17 INFO - Installing collected packages: psutil 03:11:17 INFO - Running setup.py install for psutil 03:11:17 INFO - building 'psutil._psutil_osx' extension 03:11:17 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 03:11:17 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 03:11:18 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 03:11:18 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 03:11:18 INFO - building 'psutil._psutil_posix' extension 03:11:18 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 03:11:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:11:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:11:18 INFO - ^ 03:11:18 INFO - 1 warning generated. 03:11:18 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 03:11:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:11:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:11:18 INFO - Successfully installed psutil 03:11:18 INFO - Cleaning up... 03:11:18 INFO - Return code: 0 03:11:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:11:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:11:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:18 INFO - 'HOME': '/Users/cltbld', 03:11:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:18 INFO - 'LOGNAME': 'cltbld', 03:11:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:18 INFO - 'MOZ_NO_REMOTE': '1', 03:11:18 INFO - 'NO_EM_RESTART': '1', 03:11:18 INFO - 'PAGER': '/bin/cat', 03:11:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:18 INFO - 'PWD': '/builds/slave/test', 03:11:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:18 INFO - 'SHELL': '/bin/bash', 03:11:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:18 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:18 INFO - 'USER': 'cltbld', 03:11:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:18 INFO - 'XPC_FLAGS': '0x0', 03:11:18 INFO - 'XPC_SERVICE_NAME': '0', 03:11:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:11:21 INFO - Installing collected packages: mozsystemmonitor 03:11:21 INFO - Running setup.py install for mozsystemmonitor 03:11:21 INFO - Successfully installed mozsystemmonitor 03:11:21 INFO - Cleaning up... 03:11:21 INFO - Return code: 0 03:11:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:11:21 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')]} 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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')]} 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:21 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:21 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 03:11:21 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 03:11:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:21 INFO - 'HOME': '/Users/cltbld', 03:11:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:21 INFO - 'LOGNAME': 'cltbld', 03:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:21 INFO - 'MOZ_NO_REMOTE': '1', 03:11:21 INFO - 'NO_EM_RESTART': '1', 03:11:21 INFO - 'PAGER': '/bin/cat', 03:11:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:21 INFO - 'PWD': '/builds/slave/test', 03:11:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:21 INFO - 'SHELL': '/bin/bash', 03:11:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:21 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:21 INFO - 'USER': 'cltbld', 03:11:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:21 INFO - 'XPC_FLAGS': '0x0', 03:11:21 INFO - 'XPC_SERVICE_NAME': '0', 03:11:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:11:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:11:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:25 INFO - Downloading docopt-0.6.1.tar.gz 03:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:11:25 INFO - Installing collected packages: blobuploader, requests, docopt 03:11:25 INFO - Running setup.py install for blobuploader 03:11:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:11:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:11:25 INFO - Running setup.py install for requests 03:11:25 INFO - Running setup.py install for docopt 03:11:26 INFO - Successfully installed blobuploader requests docopt 03:11:26 INFO - Cleaning up... 03:11:26 INFO - Return code: 0 03:11:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:26 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')]} 03:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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')]} 03:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:26 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:26 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 03:11:26 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 03:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:26 INFO - 'HOME': '/Users/cltbld', 03:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:26 INFO - 'LOGNAME': 'cltbld', 03:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:26 INFO - 'MOZ_NO_REMOTE': '1', 03:11:26 INFO - 'NO_EM_RESTART': '1', 03:11:26 INFO - 'PAGER': '/bin/cat', 03:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:26 INFO - 'PWD': '/builds/slave/test', 03:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:26 INFO - 'SHELL': '/bin/bash', 03:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:26 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:26 INFO - 'USER': 'cltbld', 03:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:26 INFO - 'XPC_FLAGS': '0x0', 03:11:26 INFO - 'XPC_SERVICE_NAME': '0', 03:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-YL1lSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-lbcxsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-CInzct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-5BWzeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-GjDyvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:26 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-1a0n7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-2bfIQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-JsS6c1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-mBAOH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-uzMtIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-dqDdZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-t6wJla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-uiFxBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-u8LgSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-3HBX6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:27 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-tZk1Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:28 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-BPRzyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:11:28 INFO - Running setup.py install for manifestparser 03:11:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:11:28 INFO - Running setup.py install for mozcrash 03:11:28 INFO - Running setup.py install for mozdebug 03:11:28 INFO - Running setup.py install for mozdevice 03:11:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:11:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:11:28 INFO - Running setup.py install for mozfile 03:11:28 INFO - Running setup.py install for mozhttpd 03:11:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Running setup.py install for mozinfo 03:11:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Running setup.py install for mozInstall 03:11:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Running setup.py install for mozleak 03:11:29 INFO - Running setup.py install for mozlog 03:11:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Running setup.py install for moznetwork 03:11:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:11:29 INFO - Running setup.py install for mozprocess 03:11:29 INFO - Running setup.py install for mozprofile 03:11:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:11:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:11:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:11:30 INFO - Running setup.py install for mozrunner 03:11:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:11:30 INFO - Running setup.py install for mozscreenshot 03:11:30 INFO - Running setup.py install for moztest 03:11:30 INFO - Running setup.py install for mozversion 03:11:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:11:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:11:30 INFO - Cleaning up... 03:11:30 INFO - Return code: 0 03:11:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:30 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:30 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 03:11:30 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 03:11:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:30 INFO - 'HOME': '/Users/cltbld', 03:11:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:30 INFO - 'LOGNAME': 'cltbld', 03:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:30 INFO - 'MOZ_NO_REMOTE': '1', 03:11:30 INFO - 'NO_EM_RESTART': '1', 03:11:30 INFO - 'PAGER': '/bin/cat', 03:11:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:30 INFO - 'PWD': '/builds/slave/test', 03:11:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:30 INFO - 'SHELL': '/bin/bash', 03:11:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:30 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:30 INFO - 'USER': 'cltbld', 03:11:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:30 INFO - 'XPC_FLAGS': '0x0', 03:11:30 INFO - 'XPC_SERVICE_NAME': '0', 03:11:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Tnx0S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-reCYF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-9WvLhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-XQMp6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-QU8Iwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-wtgDVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-jFmlan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-wCTctG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:11:31 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)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-Gew4z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:11:31 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-zFoLba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-9iSrSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-DNXz8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-UH3BXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-oUKH37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-RgcfyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-q5ll0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:11:32 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)) 03:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:11:32 INFO - Running setup.py (path:/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/pip-rPhwch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:11:32 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)) 03:11:32 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)) 03:11:32 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)) 03:11:32 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)) 03:11:32 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)) 03:11:32 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)) 03:11:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:35 INFO - Downloading blessings-1.6.tar.gz 03:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:11:35 INFO - Installing collected packages: blessings 03:11:35 INFO - Running setup.py install for blessings 03:11:35 INFO - Successfully installed blessings 03:11:35 INFO - Cleaning up... 03:11:35 INFO - Return code: 0 03:11:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:35 INFO - Reading from file tmpfile_stdout 03:11:35 INFO - Current package versions: 03:11:35 INFO - blessings == 1.6 03:11:35 INFO - blobuploader == 1.2.4 03:11:35 INFO - docopt == 0.6.1 03:11:35 INFO - manifestparser == 1.1 03:11:35 INFO - mozInstall == 1.12 03:11:35 INFO - mozcrash == 0.17 03:11:35 INFO - mozdebug == 0.1 03:11:35 INFO - mozdevice == 0.48 03:11:35 INFO - mozfile == 1.2 03:11:35 INFO - mozhttpd == 0.7 03:11:35 INFO - mozinfo == 0.9 03:11:35 INFO - mozleak == 0.1 03:11:35 INFO - mozlog == 3.1 03:11:35 INFO - moznetwork == 0.27 03:11:35 INFO - mozprocess == 0.22 03:11:35 INFO - mozprofile == 0.28 03:11:35 INFO - mozrunner == 6.11 03:11:35 INFO - mozscreenshot == 0.1 03:11:35 INFO - mozsystemmonitor == 0.0 03:11:35 INFO - moztest == 0.7 03:11:35 INFO - mozversion == 1.4 03:11:35 INFO - psutil == 3.1.1 03:11:35 INFO - requests == 1.2.3 03:11:35 INFO - wsgiref == 0.1.2 03:11:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:35 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:35 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 03:11:35 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 03:11:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:35 INFO - 'HOME': '/Users/cltbld', 03:11:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:35 INFO - 'LOGNAME': 'cltbld', 03:11:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:35 INFO - 'MOZ_NO_REMOTE': '1', 03:11:35 INFO - 'NO_EM_RESTART': '1', 03:11:35 INFO - 'PAGER': '/bin/cat', 03:11:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:35 INFO - 'PWD': '/builds/slave/test', 03:11:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:35 INFO - 'SHELL': '/bin/bash', 03:11:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:35 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:35 INFO - 'USER': 'cltbld', 03:11:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:35 INFO - 'XPC_FLAGS': '0x0', 03:11:35 INFO - 'XPC_SERVICE_NAME': '0', 03:11:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 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)) 03:11:36 INFO - Cleaning up... 03:11:36 INFO - Return code: 0 03:11:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:11:36 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')]} 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 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')]} 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11:36 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 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11:36 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 03:11:36 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 03:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:36 INFO - 'HOME': '/Users/cltbld', 03:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:36 INFO - 'LOGNAME': 'cltbld', 03:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:36 INFO - 'MOZ_NO_REMOTE': '1', 03:11:36 INFO - 'NO_EM_RESTART': '1', 03:11:36 INFO - 'PAGER': '/bin/cat', 03:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:36 INFO - 'PWD': '/builds/slave/test', 03:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:36 INFO - 'SHELL': '/bin/bash', 03:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:36 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:36 INFO - 'USER': 'cltbld', 03:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:36 INFO - 'XPC_FLAGS': '0x0', 03:11:36 INFO - 'XPC_SERVICE_NAME': '0', 03:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:36 INFO - Downloading/unpacking jsonschema 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:11:38 INFO - Downloading/unpacking functools32 (from jsonschema) 03:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:11:39 INFO - warning: no files found matching '*.txt' 03:11:39 INFO - no previously-included directories found matching 'build' 03:11:39 INFO - no previously-included directories found matching 'dist' 03:11:39 INFO - no previously-included directories found matching '.git*' 03:11:39 INFO - Installing collected packages: jsonschema, functools32 03:11:39 INFO - Running setup.py install for functools32 03:11:39 INFO - warning: no files found matching '*.txt' 03:11:39 INFO - no previously-included directories found matching 'build' 03:11:39 INFO - no previously-included directories found matching 'dist' 03:11:39 INFO - no previously-included directories found matching '.git*' 03:11:39 INFO - Successfully installed jsonschema functools32 03:11:39 INFO - Cleaning up... 03:11:39 INFO - Return code: 0 03:11:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:11: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')]} 03:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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')]} 03:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:11: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101e0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e154c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95f8c8d600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, '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.vjCxbkNaox/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.KCbL18E7MG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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 03:11: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', 'flake8'] in /builds/slave/test/build 03:11: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 flake8 03:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:11:39 INFO - 'HOME': '/Users/cltbld', 03:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:11:39 INFO - 'LOGNAME': 'cltbld', 03:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:11:39 INFO - 'MOZ_NO_REMOTE': '1', 03:11:39 INFO - 'NO_EM_RESTART': '1', 03:11:39 INFO - 'PAGER': '/bin/cat', 03:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:11:39 INFO - 'PWD': '/builds/slave/test', 03:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:11:39 INFO - 'SHELL': '/bin/bash', 03:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:11:39 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:11:39 INFO - 'USER': 'cltbld', 03:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:11:39 INFO - 'XPC_FLAGS': '0x0', 03:11:39 INFO - 'XPC_SERVICE_NAME': '0', 03:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:11:39 INFO - Downloading/unpacking flake8 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11: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 03:11:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:11:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:11:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:11:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:11:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:43 INFO - no previously-included directories found matching 'docs/_build' 03:11:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:11:43 INFO - Running setup.py install for pep8 03:11:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:11:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:11:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:11:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:11:43 INFO - no previously-included directories found matching 'docs/_build' 03:11:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:11:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:11:43 INFO - Cleaning up... 03:11:43 INFO - Return code: 0 03:11:43 INFO - Running post-action listener: _resource_record_post_action 03:11:43 INFO - Running post-action listener: _start_resource_monitoring 03:11:43 INFO - Starting resource monitoring. 03:11:43 INFO - ##### 03:11:43 INFO - ##### Running install step. 03:11:43 INFO - ##### 03:11:43 INFO - Running pre-action listener: _resource_record_pre_action 03:11:43 INFO - Running main action method: install 03:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:11:43 INFO - Reading from file tmpfile_stdout 03:11:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:11:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:11:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:11:43 INFO - Reading from file tmpfile_stdout 03:11:43 INFO - Output received: 03:11:43 INFO - Usage: mozinstall [options] installer 03:11:43 INFO - Options: 03:11:43 INFO - -h, --help show this help message and exit 03:11:43 INFO - -d DEST, --destination=DEST 03:11:43 INFO - Directory to install application into. [default: 03:11:43 INFO - "/builds/slave/test"] 03:11:43 INFO - --app=APP Application being installed. [default: firefox] 03:11:43 INFO - mkdir: /builds/slave/test/build/application 03:11:43 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'] 03:11:43 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 03:12:18 INFO - Reading from file tmpfile_stdout 03:12:18 INFO - Output received: 03:12:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 03:12:18 INFO - Running post-action listener: _resource_record_post_action 03:12:18 INFO - ##### 03:12:18 INFO - ##### Running run-tests step. 03:12:18 INFO - ##### 03:12:18 INFO - Running pre-action listener: _resource_record_pre_action 03:12:18 INFO - Running main action method: run_tests 03:12:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:12:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:12:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:12:18 INFO - 2016-03-09 03:12:18.089 screenresolution[6442:107331] starting screenresolution argv=screenresolution get 03:12:18 INFO - 2016-03-09 03:12:18.092 screenresolution[6442:107331] Display 0: 1600x1200x32@60 03:12:18 INFO - 2016-03-09 03:12:18.098 screenresolution[6443:107333] starting screenresolution argv=screenresolution list 03:12:18 INFO - Available Modes on Display 0 03:12:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:12:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:12:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:12:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:12:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:12:18 INFO - Intel Iris: 03:12:18 INFO - Chipset Model: Intel Iris 03:12:18 INFO - Type: GPU 03:12:18 INFO - Bus: Built-In 03:12:18 INFO - VRAM (Dynamic, Max): 1536 MB 03:12:18 INFO - Vendor: Intel (0x8086) 03:12:18 INFO - Device ID: 0x0a2e 03:12:18 INFO - Revision ID: 0x0009 03:12:18 INFO - Displays: 03:12:18 INFO - Display: 03:12:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:12:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:12:18 INFO - Display Serial Number: 1600x1200 60 03:12:18 INFO - Main Display: Yes 03:12:18 INFO - Mirror: Off 03:12:18 INFO - Online: Yes 03:12:18 INFO - Rotation: Supported 03:12:18 INFO - Return code: 0 03:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:12:18 INFO - Python 2.7.3 03:12:18 INFO - Return code: 0 03:12:18 INFO - grabbing minidump binary from tooltool 03:12: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')]} 03:12:18 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 0x101cb1d30>, '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 0x101ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101ca8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:12:18 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 03:12:18 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 03:12:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:12:18 INFO - Return code: 0 03:12:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:12:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:12:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:12:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:12:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:12:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:12:19 INFO - Return code: 0 03:12:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 03:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0052 --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 03:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vjCxbkNaox/Render', 03:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:19 INFO - 'HOME': '/Users/cltbld', 03:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:19 INFO - 'LOGNAME': 'cltbld', 03:12:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:12:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:19 INFO - 'MOZ_NO_REMOTE': '1', 03:12:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:12:19 INFO - 'NO_EM_RESTART': '1', 03:12:19 INFO - 'PAGER': '/bin/cat', 03:12:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:19 INFO - 'PWD': '/builds/slave/test', 03:12:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:19 INFO - 'SHELL': '/bin/bash', 03:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KCbL18E7MG/Listeners', 03:12:19 INFO - 'TMPDIR': '/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/', 03:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:19 INFO - 'USER': 'cltbld', 03:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:19 INFO - 'XPC_FLAGS': '0x0', 03:12:19 INFO - 'XPC_SERVICE_NAME': '0', 03:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0052', '--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 03:12:19 INFO - mozversion application_buildid: 20160308030418 03:12:19 INFO - mozversion application_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 03:12:19 INFO - mozversion application_display_name: Nightly 03:12:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:12:19 INFO - mozversion application_name: Firefox 03:12:19 INFO - mozversion application_remotingname: firefox 03:12:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:12:19 INFO - mozversion application_vendor: Mozilla 03:12:19 INFO - mozversion application_version: 48.0a1 03:12:19 INFO - mozversion platform_buildid: 20160308030418 03:12:19 INFO - mozversion platform_changeset: 05c087337043dd8e71cc27bdb5b9d55fd00aaa26 03:12:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:12:19 INFO - mozversion platform_version: 48.0a1 03:12:19 INFO - using testdate: 1457521939 03:12:19 INFO - actual date: 1457521939 03:12:19 INFO - starting webserver on 'localhost:56516' 03:12:19 INFO - SUITE-START | Running 2 tests 03:12:19 INFO - TEST-START | dromaeo_css 03:12:19 INFO - operating with platform_type : mac_ 03:12:19 INFO - Initialising browser for dromaeo_css test... 03:12:19 INFO - TEST-INFO | started process 6461 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpFfdnIt/profile http://localhost:56516/getInfo.html) 03:12:22 INFO - PROCESS | 6461 | __metrics Screen width/height:1600/1200 03:12:22 INFO - PROCESS | 6461 | colorDepth:24 03:12:22 INFO - PROCESS | 6461 | Browser inner width/height: 1024/689 03:12:22 INFO - PROCESS | 6461 | __metrics 03:12:22 INFO - PROCESS | 6461 | 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" 03:12:22 INFO - PROCESS | 6461 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:12:22 INFO - TEST-INFO | 6461: exit 0 03:12:22 INFO - Browser initialized. 03:12:22 INFO - Running cycle 1/1 for dromaeo_css test... 03:12:22 INFO - TEST-INFO | started process 6464 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpFfdnIt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:34 INFO - PROCESS | 6464 | RSS: Main: 246218752 03:12:34 INFO - PROCESS | 6464 | 03:13:25 INFO - PROCESS | 6464 | 1457522005796 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] 03:15:35 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56516/tests/dromaeo/cssquery-ext.html) 03:15:37 INFO - PROCESS | 6464 | RSS: Main: 401690624 03:15:37 INFO - PROCESS | 6464 | 03:18:39 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-ext.html (next: http://localhost:56516/tests/dromaeo/cssquery-jquery.html) 03:18:40 INFO - PROCESS | 6464 | RSS: Main: 374874112 03:18:40 INFO - PROCESS | 6464 | 03:21:42 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56516/tests/dromaeo/cssquery-mootools.html) 03:21:42 INFO - PROCESS | 6464 | RSS: Main: 379944960 03:21:42 INFO - PROCESS | 6464 | 03:24:44 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56516/tests/dromaeo/cssquery-prototype.html) 03:24:45 INFO - PROCESS | 6464 | RSS: Main: 333144064 03:24:45 INFO - PROCESS | 6464 | 03:27:48 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56516/tests/dromaeo/cssquery-yui.html) 03:27:49 INFO - PROCESS | 6464 | RSS: Main: 334692352 03:27:49 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | Cycle 1(1): loaded http://localhost:56516/tests/dromaeo/cssquery-yui.html (next: http://localhost:56516/tests/dromaeo/cssquery-dojo.html) 03:30:52 INFO - PROCESS | 6464 | RSS: Main: 390778880 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | __start_tp_report 03:30:52 INFO - PROCESS | 6464 | _x_x_mozilla_page_load 03:30:52 INFO - PROCESS | 6464 | _x_x_mozilla_page_load_details 03:30:52 INFO - PROCESS | 6464 | |i|pagename|runs| 03:30:52 INFO - PROCESS | 6464 | |0;dojo.html;2729.2358139720877;3394.1514621344663;3418.2821607462424;3438.879639212625;3476.7913925164494;5544.6395984261;5568.303962004755;5573.721313934302;5585.972070139649;5612.158176273561;5491.258680078188;5555.083411237151;5559.3328800543995;5563.554915606752;5579.246801681772;5037;5045.596352291808;5067.721275329855;5159.509846564571;5162.638615296931;5056.544910958013;5133.845984620468;5150.587952963772;5164.4060932992625;5164.974175129119;5050.242463630448;5070.2141168118815;5093.719845408501;5112.616553758465;5134.717590532519;5109.4379618241965;5128.794848206067;5135.101357262502;5150.768215430277;5202.375714914235;4983.825566105169;5010.323606313137;5068.113080210986;5069.138246498104;5106.361704786902;4520.864374068783;5468.070428027245;5469.56243500519;5481.890362192774;5574.637648552831;6123.173371594867;6156.56904016719;6165.907511387333;6168.475679567242;6174.259088909314;4677.6257899367965;6096.1770161028135;6217.782377616807;6219.595726277777;6230.906536401958;5534.1975413565615;5534.584906132056;5548.667079975215;5553.194786755897;5587.413321601214;6134.754609815646;6179.351168127372;6193.969030154911;6197.876042479215;6202.81391558254;5853.560982926212;5931.584789064724;5969.194158788508;6061.393860613992;6104.084387341845;6102.350431610208;6122.438798062313;6126.36500017443;6142.539309551801;6146.354632763585;6030.909536356959;6031.60794548353;6041.335453100155;6049.001914684028;6054.273487181566;5960.642361458326;6055.666938318347;6135.69203737716;6150.446459818638;6156.753729850845;4789.137955168034;4798.2802579613335;4798.49615790337;4827.324174615556;4864.36763220779;4246.4691913510815;4319.97840010798;4339.067100573392;4343.9348409773875;4392.231359512072;5508.807191748269;5564.499195072382;5601.859953501195;5615.971920140373;5620.100783874561;6171;6178.227721534809;6184.134221209034;6187.102870083812;6188.195534580475;5465.098258787335;5533.723313834373;5577.553795696415;5584.860378490489;5606.299212598426;5214.400343960418;5221.295125158055;5274.472552744694;5282.97358513205;5307.867303317371;6240.438360547572;6245.843853903689;6259.843503912439;6278.811635650938;6289.591176573416;6031.819045428644;6143.232095988002;6155.230596175478;6155.784547540994;6160;5344.919826202688;5365.248865158803;6197.791430670976;6229;6244.188255526752;5981.618050635144;6004.39956004396;6005.1892994446935;6061.212042434631;6061.36355682647;5999.100134979788;6102.420270074336;6137.815865524041;6157.415045570664;6168.475679567107;5849.888521180962;5856.853578660568;5870.14882841994;5874.5887787854435;5876.3536011037895;5694.373618902;5837.766489340549;5915.08316210988;6014;6024.487918526975;4509.751963642031;5740.483356497935;5788.479036886701;5796.449337312949;5809.767609295581;5974.074018527135;5980.790672326448;5981.7308221131025;5996.820095397145;5999.1901093351835;5155.200943853709;5684.63049901755;5743.4256574342235;5786.768529258951;5794.913076303943 03:30:52 INFO - PROCESS | 6464 | |1;ext.html;443.80916206031435;573.7749903955057;576.1012820000799;580.2393606851987;639.9552031357805;24946;31039.379212415737;31071.689283107164;31091.222719432026;31092;31621.841890790514;41003.58996410042;41321.14054867531;41438.378424323586;41533;9520.571574279174;9727.805443891119;9752.512374381287;9758.560864761102;9760.755981100458;9587.808243835154;9690.515474226295;9704;9724.805503889918;9729.756756081084;9701.223902087817;9749.95125024374;9762.414255144678;9763.609455621767;9768.560414781316;9644.710658680251;9873.160781333596;9873.40759554429;9874.358166719141;9876.851847222333;9632.181264592518;9765.90234097657;9783.90216097837;9800.509974501247;9800.656977005841;41996;42307.15385692269;42318.57681423177;42340;42390.36414453786;3153.5427363032463;3205.1987003249187;3326.417876871538;3403.1662242750435;3418.26507300929;27987.300317492023;28959.56560651592;28974.275643108882;28974.27564310909;28984;2694.582339737344;2696.6089916961932;2809.395979864339;2844.431113777232;2870.799044066916;505804.4709776464;505900;510829;511466;512705;64928;65615.34384656188;65827.34172658212;65846.01230981539;65958.67020664962;75814.24185758182;76250;76315.61842190864;76336.61831690917;76372.61813691007;14370.425182992563;14839.777403338958;17910.283588656308;17990.370337038403;18019.459416217534;13334.333283335794;13365.599032029055;13398.06213565041;13399.665008374868;13409.597712068653;21107;22251.666225006637;22252;22257.332280031624;22271;7876.527408355517;8282.461639993382;9850.60597576089;9862.654807081717;9916.752081197883;900.3877363392825;989.475577943691;1001.8497225416246;1056.9894301057045;1083.1713738989679;26208.8689556551;29379.85310073479;29482.43022331542;29695;30199.547006794917;951.3673407184145;1045.2839804733783;1109.312226419625;1113.1984970820995;1122.36586328724;14178.858211417753;14217.146971181763;14463.915206359565;14688.632784180481;14798.038127521677;522575;522907;523158;523897.9466334676;523959;59336.703316484;61583.38416615866;61681;61736;61789.38210617926;1314.8553659097493;1336.832895888014;1439.755241608929;1450.9564713058414;1464.5606318104526;23839;27874.721252787214;28941.710582893902;29317.706822931497;29464.55803162997;34843.477347839296;47426.05147897092;47472.8131796694;47484;47537.76231118822;267642;363469;367049;367455;368598;28825.711742882304;30148.84925575358;31767.93508421945;33001.83499082489;33064.50403244001;42003.949901252716;42296;42417.36373954331;43949.78025109854;43978.56021439873;35260.47109293311;35323.58705651745;35414.468782967764;36044;36351.636483635884;35345;36007.0998225036;36104.27791444104;37206;37826;35567;35919.64080359163;36069.819650901576;36463.635363646026;37272.627273728;31895.620875824465;33720.1569960753;34434;34779.652203478654;34931.47602786011;23667.52664946657;24225;24690.50618987646;24714.382140446633;24847 03:30:52 INFO - PROCESS | 6464 | |2;jquery.html;365.8061227549399;372.8229091181689;373.3298728781836;378.0209258021723;379.597626515893;19866.602667946652;20247.797522024775;20369.796302036975;20658.173673053097;20762.9618519074;19601.607967840635;19612;20174.899125504387;20254.49363765903;20312.085956131974;5657.23627310313;5804.767809287623;5846.795362162326;5860.882782344351;5869.354371019184;5598.216249725042;5853.239078919734;5867.239828051589;5871.647701137924;5877.14781356703;5914.142449344842;5925.259342582177;5928.911066334009;5943.613665111776;5960.284765828107;5909.320428150753;6356.237251529823;6452.225732912034;6513;6530.2816690164045;5705;5740.225069615632;5744.253247077895;5747.3103227612955;5748.942510574882;23442;23815.951288281034;24140.155094571604;24921.750782492305;24971.250862473975;2049.5286084200716;2130.1479408236673;2157.7626461089426;2199.5051113499335;2226.25420484138;9739.366941148874;11477.483513241925;13338.13302135358;14377.353019114165;15142.394304227817;1751.1506919144206;1769.9469015929542;1792.542901560094;1799.4691565988064;1889.4803928919519;105830;108774;110420.4478977608;112559.06043288445;112689;11191.44042797873;11323.207375483636;11325.490352934137;11335.036521895567;11462.025727813063;13661.795073073912;13665.931670341584;13743.725125497434;13754.243516606683;13762;7067.7631414503285;8536.914630853613;8653.826923461496;8762.255208307366;8787.384883058252;8883.689070882618;8901.376903616685;8903.465792052368;8998.460092394478;9023.187913087853;4468.151051300242;4545.499995000548;4548.999220171557;4552.658550608718;4601.079784043205;1840.4938641873325;1868.7570615820127;1880.9247630094917;1887.3205645967441;1893.9621207576047;931.2829121576484;966.7776411425411;969.1713584884822;989.8317286061387;991.4051569058507;19259.90370048141;20070.824139974717;20300.984950752405;20346.898265508873;21028.579428411347;890.7684002159485;971.1696499492832;976.2092704909046;999.1756800639502;1034.6430481483876;10439.478026098817;10450.798158211903;10495.842562361571;10663.573457061631;10714.839277410845;629344;635032;640512;641104;652684;115491.42254288675;116799;121964.39017804855;122499;124885.50228995369;899.7300809757178;1031.7979553819866;1043.3009883378154;1058.8200005999;1060.16247164739;13488.93255533716;15353.923230383776;17807.643847123243;18062.187201575696;18365.898046117276;38167.427488587135;53968.46031539791;54034.729826350616;54038.72980635072;56120.26556813208;75422.62288688522;78214.608926955;78216.60891695505;78842.21157788349;79542.6022869882;7888.092869320101;7923.819420851745;8012.959935200287;8038.356931445587;8204.113053997733;12938.676533086747;13147.802782958071;13328.733425331633;13423.395947182595;13491.595252142451;11263.436828158723;11435;11555.8266625999;11652.242604230698;11690.064794816564;9025.864612030693;9643.517824108907;10936.23446358779;11097.500612472297;11697.824532632187;8672;11508.138225239205;11903.928646421864;11921;11943.925046745835;7977.401694872791;8095.352371810123;8158.8776168356335;8364;8370.246677798783;11070.169737269576;11771.352575608424;11821.113416493625;12013.459394327101;12060.97481714029 03:30:52 INFO - PROCESS | 6464 | |3;mootools.html;1440.25106944389;1591.2600640702074;1628.2835552356967;1921.7789954155276;2045.6726923692213;7997.800054998628;8539.743807685763;8667.479951202933;8679.956600217005;8697.565121743903;8450.57747112645;8732.476051436919;8733;8735.257503112243;8757.474551526913;2175.6627722703006;2422.4065104049446;2433.257856353816;2466.1738317663603;2484.888180031894;2495.25142457263;2502.5745623244093;2504.486580251053;2508.423062695581;2509.8494090354548;2425.3209101451534;2470.0737223541173;2485.6023036314195;2487.452760392711;2487.8382905111202;2409.494006258688;2429.4898071405028;2441.755824417553;2455.9263222103364;2457.0908763757348;2425.987870060656;2427.599446091393;2446.97553024471;2449.926502204919;2454.47228845799;8778.561071946377;8897.199252067345;8902.510361930092;8906.86639700405;8911.598978046004;5468.207109969072;5564.10974244119;5570.916436253459;5605.971970140124;5611.961787069365;3567.714582833367;3668.4497325401135;3728.8694895678523;3761.774293542369;3765.849366025383;1031.2059714020163;1051.2378525568977;1051.5636011055478;1061.851340812287;1062.0494657281768;12198.39008049594;12221.327826969513;12233.327167005811;12244.510219591206;12263.386830658432;4861;4902.1911384621135;4977;4978.327925730053;5008.670967999825;10207.387556746618;10215;10223.693289201336;10246.231532635082;10253.692389228336;5586.972065139648;5591.993441180626;5598.636088654224;5599.972000139973;5608.775648974077;4461.977690111528;4564.954350456453;4804.855854324376;4959.702417854868;5013.047520971004;3899.434581985653;3962.6829853611644;3981.283368993551;4017.9196416071513;4025.0943537703783;1140.6349968010322;1275.6364436135657;1304.3543445994103;1319.5711393797055;1331.5738963531771;1291.8126871603565;1314.5399110311505;1330.2882957617821;1336.4587342126454;1353.1813252982001;8149.348052155813;8332.458390204618;8337.791555211046;8350.415470916978;8353.540555269397;498.84286449768206;507.1454599000622;513.6609837507227;518.6550943622524;519.586724110419;6197.938020619827;6210;6256.499480041586;6269.059641053787;6276.529260305495;9499.38254013487;10369.585216591402;10428.687139385831;10703.929607039234;10852.72868178286;10053.79892402148;10616.840747388795;10703.46482675863;10708.946455267675;10711.25021248505;8411.873821892677;8457.746267612105;8503.702370417006;8558.572071396406;8561.914380856237;8243.422960392714;8278.544680042656;8306.792330191794;8357.122502137188;8401.411901166859;9561.235101191749;9685.32202745801;9799.608015679292;9962.651307204504;9981.151602113901;9888.307818452638;10089;10243.539040743333;10253.692389228336;10281.794364112826;6719.092922455601;7318.707251710085;7577.5453472791805;7607.353374962969;7709;8365.205305495969;8385.245327920517;8424.115467875785;8430.704925327584;8433;7249.311315425026;7300.671469783979;7308.707651694085;7458.776236712907;7490.737824176128;6084.60450070744;7137.393321567725;7243.3843123333;7296.635168241673;7370.926290737024;7567.886481702889;7713.19011503784;7723.189065148079;7725.1502334744255;7735.110462296683;6919.550229235084;7014.894776578458;7016.193137789015;7016.228214896255;7021.859562808818;6848.075509806113;7088.184858741104;7090.787276381717;7091.929080709333;7113.608751518716 03:30:52 INFO - PROCESS | 6464 | |4;prototype.html;260.36471010733806;329.49093650310266;330.6643756587064;336.58431836681694;342.05251453473863;6287.402696743808;6515.543911926167;6529.608223506593;6569.277379488252;6571.7042733077005;6358.872822543558;6458.967705161479;6480.416762491375;6492.448141907944;6505.5120865935005;4526.705764125321;4608.695652173913;4630.652701047418;4758.095961767271;4782.497837727041;4675.625949924015;4706.576408123268;4710.97644511777;4727.149113159629;4741.336212930192;4662.836800711976;4665.09030739006;4673.532646735333;4688.226442636961;4710.411198600175;4494.16857881293;4519.276915693474;4645.140648979949;4658.650601204923;4708.929366059512;3217.501287300472;3945.861894833667;3951.6641085507767;3976.602339766029;3981.7013723970526;4848.709077455329;6082.695865206766;6143.232095988002;6143.631382117042;6173.753049878;5442.809501667462;5444.40111587725;5451.100568406208;5454.91817622736;5455.345358556959;6806.829829254259;6806.897896531556;6809;6811.594202898551;6818.454523638097;4297.333913243452;4454.465464144323;4456.108778244332;4481.439820022497;4504.346869703907;7189.496735228536;7241.058662373857;7298.12422509297;7298.3066608672625;7304.196538380774;4531.161735079021;4557.316402539579;4560.224761790503;4560.954390456053;4567.337736028324;3869.496965394537;4597.931031034537;4610.76946152691;4621.19129152397;4624.745638989888;5461.371942226695;5462.344518657707;5470.452954704498;5475.479829416199;5481.698506582176;6306.684665766693;6661.367170118831;6875.312468753084;6905.447564194953;6919.37725604698;1494.4532408956677;1581.351645825206;1599.856012958816;1602.671452352265;1603.7915071040923;1020.102309967239;1030.6804890483975;1032.7986042721598;1039.5841663334575;1047.8480620310013;6256.874862502725;6396.584222025554;6421.422072013541;6436.935630643728;6437.356264373525;6995.055667484926;7226.0606121204955;7229.602371869598;7230.783076507608;7241.89137162943;6507.186601674791;6515.087887695727;6527.5430719849155;6530.346965303432;6531.248906375828;3732.1789206374556;3801.163743976321;3805.296020236265;3805.486259355007;3812.5615554211067;7264.019357386685;7455.2172021938;7525.134609519866;7540.434467414966;7546.320831125225;7372.115346158495;7424.294692004359;7425.480216384909;7429.034225550752;7466.664000120008;7498.812529686801;7504.099508059068;7505.099388073466;7507.324340809244;7519.812004699927;7156.606386648784;7167.426605871414;7192.784216473514;7205.747798827016;7207.315305046012;6130.9883869161085;6409.230892292955;7085.468589855678;7128.429725621834;7139.214686384597;7488.288612581796;7535.171131175457;7552.735654252075;7555.433342499445;7679.3856491481665;4510.368548403292;4558.931616025696;4562.338460923214;4565.977170114128;4570.702904311209;7142.071530700976;7149.285071492809;7172.820679483055;7177.820554486179;7178.892316615151;6641.767538136142;6850.897236541556;6900.551464154814;6925.792226233221;6932.688029038604;6855.622940738108;6906.307954551167;6909.205441374306;6912;6914.377706006484;6731.528792984444;6740.9325906740305;6743.1908171019795;6749.055132281583;6766.323367663391;6876.759313424006;6896.069030680995;6901.689423975833;6906.8618627626165;6910.378065973885;6516.348365163446;6522.706478208397;6597.670116494252;6669.266380698023;6768.323167683192 03:30:52 INFO - PROCESS | 6464 | |5;yui.html;664.0636702249826;683.3644710419314;706.6078326528777;763.5456903142629;768.5081547809402;17671.823281767178;18026;18062.5484362891;18092.276308947625;18099.18553665085;15110.791136709064;15114;15237.314320855588;15254.694906101871;15276;741.2994719989612;750.2909750285982;781.3475747750635;939.4785893828939;962.1052421248237;942.2462030375706;950.1591091883664;951.4861974533743;952.2429668413594;953.2897990996718;1016.6543375252413;1017.7252141921676;1017.9745506362364;1019.4851599942056;1019.8929112443197;775.8215610409609;780.9648565814553;787.582581231948;788.2432864450135;1007.3301254665638;725.7459889038847;740.5223630758185;741.2180149941863;745.4967896669726;745.4967896669781;15378.461753838563;15429.768553471595;15458.768118478232;15463.226838658022;15468;12432.254064756144;12528.060395470377;12579.597141000668;12839.679008024781;12883.742325153444;10076.949615251877;10193.337433066827;10269.435181065039;10336.844947325797;11017.394043327613;3413.5562376891094;3460.446328587439;3466.098814308298;3469.3234819210265;3527.224010717638;87211;88123.11876881277;88311.93504519622;88329;88580.99999999936;9142.360034797633;9318.90681093194;9414.435133891988;9540.475273859865;9576.616935322509;21267.78732212658;21304.893475532834;21357.78642213558;21414.25050123238;21416.892915535635;7295.744648937261;7406.666699998513;7429.814254643569;7446.032015838015;7454.85090298191;3559.964400356015;4019.7588144711412;4025.1748391579654;4107.650849677811;4129.236091323115;3415.692587667122;3521.5950165730756;3525.541679581638;3590;3637.690796282293;652.6214795418646;664.1333060356185;664.3854434647932;670.6814263224929;671.1308855032744;556.3435146527056;562.3364429972671;569.6126633888995;581.3809285228816;609.7195290166485;6745.898811517831;8014.839703205903;8047.275745182962;8050.355971522381;8080.070791858894;528.9629725919226;532.2149829002191;553.4714347797843;564.8983183027012;623.9642193958008;3793.734438589272;3826.9234615307537;3833.654971052563;3844.9231015379537;3879.2241551689776;91005;91035.63446548308;91139;91355.54322228346;95572;71688.92466613006;72856;72923;73467;76507;62441;62726.37273627205;63033;63259.367406326266;64714.35285647177;7538.170801211972;7616.5810880399895;7821.022372203474;7957.960210199143;8455.450395724258;49015.019699605095;50691;50785;51315.97368052693;52194.739026304625;71911.64044179746;72645.6367718158;73439.63280183564;73673.6316318415;75429;9072.673511537854;9230.815383692154;10588.894111058791;10711.732206694895;11352.602658906899;11720.413979301171;12040.337781422106;12064.215825971283;12155.270683759003;12294.262344259372;11503.194776365573;11621.418929053683;11786.002009090378;11981.460834262305;12008.459619317326;11433.771324573296;11434.028107610946;11531.88468115308;11558.653240402802;11631.88368116308;11155.442227888736;11481.425928703698;11618.128640352177;11757.588484403004;12290.938545307215;9711.465869377253;9711.708648740549;9755;9883.308168428428;9911.207103431563;8931.73204803857;8960.507172105597;9249.907500925174;9760.69210911884;9875.20998320147 03:30:52 INFO - PROCESS | 6464 | __end_tp_report 03:30:52 INFO - PROCESS | 6464 | __start_cc_report 03:30:52 INFO - PROCESS | 6464 | _x_x_mozilla_cycle_collect,1398 03:30:52 INFO - PROCESS | 6464 | __end_cc_report 03:30:52 INFO - PROCESS | 6464 | __startTimestamp1457523052493__endTimestamp 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | ------- Summary: start ------- 03:30:52 INFO - PROCESS | 6464 | Number of tests: 6 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#0] dojo.html Cycles:165 Average:5584.74 Median:5740.48 stddev:645.20 (11.2%) stddev-sans-first:607.05 03:30:52 INFO - PROCESS | 6464 | Values: 2729.2 3394.2 3418.3 3438.9 3476.8 5544.6 5568.3 5573.7 5586.0 5612.2 5491.3 5555.1 5559.3 5563.6 5579.2 5037.0 5045.6 5067.7 5159.5 5162.6 5056.5 5133.8 5150.6 5164.4 5165.0 5050.2 5070.2 5093.7 5112.6 5134.7 5109.4 5128.8 5135.1 5150.8 5202.4 4983.8 5010.3 5068.1 5069.1 5106.4 4520.9 5468.1 5469.6 5481.9 5574.6 6123.2 6156.6 6165.9 6168.5 6174.3 4677.6 6096.2 6217.8 6219.6 6230.9 5534.2 5534.6 5548.7 5553.2 5587.4 6134.8 6179.4 6194.0 6197.9 6202.8 5853.6 5931.6 5969.2 6061.4 6104.1 6102.4 6122.4 6126.4 6142.5 6146.4 6030.9 6031.6 6041.3 6049.0 6054.3 5960.6 6055.7 6135.7 6150.4 6156.8 4789.1 4798.3 4798.5 4827.3 4864.4 4246.5 4320.0 4339.1 4343.9 4392.2 5508.8 5564.5 5601.9 5616.0 5620.1 6171.0 6178.2 6184.1 6187.1 6188.2 5465.1 5533.7 5577.6 5584.9 5606.3 5214.4 5221.3 5274.5 5283.0 5307.9 6240.4 6245.8 6259.8 6278.8 6289.6 6031.8 6143.2 6155.2 6155.8 6160.0 5344.9 5365.2 6197.8 6229.0 6244.2 5981.6 6004.4 6005.2 6061.2 6061.4 5999.1 6102.4 6137.8 6157.4 6168.5 5849.9 5856.9 5870.1 5874.6 5876.4 5694.4 5837.8 5915.1 6014.0 6024.5 4509.8 5740.5 5788.5 5796.4 5809.8 5974.1 5980.8 5981.7 5996.8 5999.2 5155.2 5684.6 5743.4 5786.8 5794.9 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#1] ext.html Cycles:180 Average:61119.19 Median:199910.32 stddev:124344.50 (62.2%) stddev-sans-first:124609.87 03:30:52 INFO - PROCESS | 6464 | Values: 443.8 573.8 576.1 580.2 640.0 24946.0 31039.4 31071.7 31091.2 31092.0 31621.8 41003.6 41321.1 41438.4 41533.0 9520.6 9727.8 9752.5 9758.6 9760.8 9587.8 9690.5 9704.0 9724.8 9729.8 9701.2 9750.0 9762.4 9763.6 9768.6 9644.7 9873.2 9873.4 9874.4 9876.9 9632.2 9765.9 9783.9 9800.5 9800.7 41996.0 42307.2 42318.6 42340.0 42390.4 3153.5 3205.2 3326.4 3403.2 3418.3 27987.3 28959.6 28974.3 28974.3 28984.0 2694.6 2696.6 2809.4 2844.4 2870.8 505804.5 505900.0 510829.0 511466.0 512705.0 64928.0 65615.3 65827.3 65846.0 65958.7 75814.2 76250.0 76315.6 76336.6 76372.6 14370.4 14839.8 17910.3 17990.4 18019.5 13334.3 13365.6 13398.1 13399.7 13409.6 21107.0 22251.7 22252.0 22257.3 22271.0 7876.5 8282.5 9850.6 9862.7 9916.8 900.4 989.5 1001.8 1057.0 1083.2 26208.9 29379.9 29482.4 29695.0 30199.5 951.4 1045.3 1109.3 1113.2 1122.4 14178.9 14217.1 14463.9 14688.6 14798.0 522575.0 522907.0 523158.0 523897.9 523959.0 59336.7 61583.4 61681.0 61736.0 61789.4 1314.9 1336.8 1439.8 1451.0 1464.6 23839.0 27874.7 28941.7 29317.7 29464.6 34843.5 47426.1 47472.8 47484.0 47537.8 267642.0 363469.0 367049.0 367455.0 368598.0 28825.7 30148.8 31767.9 33001.8 33064.5 42003.9 42296.0 42417.4 43949.8 43978.6 35260.5 35323.6 35414.5 36044.0 36351.6 35345.0 36007.1 36104.3 37206.0 37826.0 35567.0 35919.6 36069.8 36463.6 37272.6 31895.6 33720.2 34434.0 34779.7 34931.5 23667.5 24225.0 24690.5 24714.4 24847.0 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#2] jquery.html Cycles:180 Average:35676.59 Median:12834.13 stddev:106064.77 (826.4%) stddev-sans-first:106329.17 03:30:52 INFO - PROCESS | 6464 | Values: 365.8 372.8 373.3 378.0 379.6 19866.6 20247.8 20369.8 20658.2 20763.0 19601.6 19612.0 20174.9 20254.5 20312.1 5657.2 5804.8 5846.8 5860.9 5869.4 5598.2 5853.2 5867.2 5871.6 5877.1 5914.1 5925.3 5928.9 5943.6 5960.3 5909.3 6356.2 6452.2 6513.0 6530.3 5705.0 5740.2 5744.3 5747.3 5748.9 23442.0 23816.0 24140.2 24921.8 24971.3 2049.5 2130.1 2157.8 2199.5 2226.3 9739.4 11477.5 13338.1 14377.4 15142.4 1751.2 1769.9 1792.5 1799.5 1889.5 105830.0 108774.0 110420.4 112559.1 112689.0 11191.4 11323.2 11325.5 11335.0 11462.0 13661.8 13665.9 13743.7 13754.2 13762.0 7067.8 8536.9 8653.8 8762.3 8787.4 8883.7 8901.4 8903.5 8998.5 9023.2 4468.2 4545.5 4549.0 4552.7 4601.1 1840.5 1868.8 1880.9 1887.3 1894.0 931.3 966.8 969.2 989.8 991.4 19259.9 20070.8 20301.0 20346.9 21028.6 890.8 971.2 976.2 999.2 1034.6 10439.5 10450.8 10495.8 10663.6 10714.8 629344.0 635032.0 640512.0 641104.0 652684.0 115491.4 116799.0 121964.4 122499.0 124885.5 899.7 1031.8 1043.3 1058.8 1060.2 13488.9 15353.9 17807.6 18062.2 18365.9 38167.4 53968.5 54034.7 54038.7 56120.3 75422.6 78214.6 78216.6 78842.2 79542.6 7888.1 7923.8 8013.0 8038.4 8204.1 12938.7 13147.8 13328.7 13423.4 13491.6 11263.4 11435.0 11555.8 11652.2 11690.1 9025.9 9643.5 10936.2 11097.5 11697.8 8672.0 11508.1 11903.9 11921.0 11943.9 7977.4 8095.4 8158.9 8364.0 8370.2 11070.2 11771.4 11821.1 12013.5 12061.0 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#3] mootools.html Cycles:180 Average:6093.99 Median:516.16 stddev:3239.69 (627.7%) stddev-sans-first:3229.90 03:30:52 INFO - PROCESS | 6464 | Values: 1440.3 1591.3 1628.3 1921.8 2045.7 7997.8 8539.7 8667.5 8680.0 8697.6 8450.6 8732.5 8733.0 8735.3 8757.5 2175.7 2422.4 2433.3 2466.2 2484.9 2495.3 2502.6 2504.5 2508.4 2509.8 2425.3 2470.1 2485.6 2487.5 2487.8 2409.5 2429.5 2441.8 2455.9 2457.1 2426.0 2427.6 2447.0 2449.9 2454.5 8778.6 8897.2 8902.5 8906.9 8911.6 5468.2 5564.1 5570.9 5606.0 5612.0 3567.7 3668.4 3728.9 3761.8 3765.8 1031.2 1051.2 1051.6 1061.9 1062.0 12198.4 12221.3 12233.3 12244.5 12263.4 4861.0 4902.2 4977.0 4978.3 5008.7 10207.4 10215.0 10223.7 10246.2 10253.7 5587.0 5592.0 5598.6 5600.0 5608.8 4462.0 4565.0 4804.9 4959.7 5013.0 3899.4 3962.7 3981.3 4017.9 4025.1 1140.6 1275.6 1304.4 1319.6 1331.6 1291.8 1314.5 1330.3 1336.5 1353.2 8149.3 8332.5 8337.8 8350.4 8353.5 498.8 507.1 513.7 518.7 519.6 6197.9 6210.0 6256.5 6269.1 6276.5 9499.4 10369.6 10428.7 10703.9 10852.7 10053.8 10616.8 10703.5 10708.9 10711.3 8411.9 8457.7 8503.7 8558.6 8561.9 8243.4 8278.5 8306.8 8357.1 8401.4 9561.2 9685.3 9799.6 9962.7 9981.2 9888.3 10089.0 10243.5 10253.7 10281.8 6719.1 7318.7 7577.5 7607.4 7709.0 8365.2 8385.2 8424.1 8430.7 8433.0 7249.3 7300.7 7308.7 7458.8 7490.7 6084.6 7137.4 7243.4 7296.6 7370.9 7567.9 7713.2 7723.2 7725.2 7735.1 6919.6 7014.9 7016.2 7016.2 7021.9 6848.1 7088.2 7090.8 7091.9 7113.6 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#4] prototype.html Cycles:180 Average:5637.91 Median:6469.69 stddev:1827.17 (28.2%) stddev-sans-first:1787.16 03:30:52 INFO - PROCESS | 6464 | Values: 260.4 329.5 330.7 336.6 342.1 6287.4 6515.5 6529.6 6569.3 6571.7 6358.9 6459.0 6480.4 6492.4 6505.5 4526.7 4608.7 4630.7 4758.1 4782.5 4675.6 4706.6 4711.0 4727.1 4741.3 4662.8 4665.1 4673.5 4688.2 4710.4 4494.2 4519.3 4645.1 4658.7 4708.9 3217.5 3945.9 3951.7 3976.6 3981.7 4848.7 6082.7 6143.2 6143.6 6173.8 5442.8 5444.4 5451.1 5454.9 5455.3 6806.8 6806.9 6809.0 6811.6 6818.5 4297.3 4454.5 4456.1 4481.4 4504.3 7189.5 7241.1 7298.1 7298.3 7304.2 4531.2 4557.3 4560.2 4561.0 4567.3 3869.5 4597.9 4610.8 4621.2 4624.7 5461.4 5462.3 5470.5 5475.5 5481.7 6306.7 6661.4 6875.3 6905.4 6919.4 1494.5 1581.4 1599.9 1602.7 1603.8 1020.1 1030.7 1032.8 1039.6 1047.8 6256.9 6396.6 6421.4 6436.9 6437.4 6995.1 7226.1 7229.6 7230.8 7241.9 6507.2 6515.1 6527.5 6530.3 6531.2 3732.2 3801.2 3805.3 3805.5 3812.6 7264.0 7455.2 7525.1 7540.4 7546.3 7372.1 7424.3 7425.5 7429.0 7466.7 7498.8 7504.1 7505.1 7507.3 7519.8 7156.6 7167.4 7192.8 7205.7 7207.3 6131.0 6409.2 7085.5 7128.4 7139.2 7488.3 7535.2 7552.7 7555.4 7679.4 4510.4 4558.9 4562.3 4566.0 4570.7 7142.1 7149.3 7172.8 7177.8 7178.9 6641.8 6850.9 6900.6 6925.8 6932.7 6855.6 6906.3 6909.2 6912.0 6914.4 6731.5 6740.9 6743.2 6749.1 6766.3 6876.8 6896.1 6901.7 6906.9 6910.4 6516.3 6522.7 6597.7 6669.3 6768.3 03:30:52 INFO - PROCESS | 6464 | 03:30:52 INFO - PROCESS | 6464 | [#5] yui.html Cycles:180 Average:18461.48 Median:575.50 stddev:25906.07 (4501.5%) stddev-sans-first:25944.27 03:30:52 INFO - PROCESS | 6464 | Values: 664.1 683.4 706.6 763.5 768.5 17671.8 18026.0 18062.5 18092.3 18099.2 15110.8 15114.0 15237.3 15254.7 15276.0 741.3 750.3 781.3 939.5 962.1 942.2 950.2 951.5 952.2 953.3 1016.7 1017.7 1018.0 1019.5 1019.9 775.8 781.0 787.6 788.2 1007.3 725.7 740.5 741.2 745.5 745.5 15378.5 15429.8 15458.8 15463.2 15468.0 12432.3 12528.1 12579.6 12839.7 12883.7 10076.9 10193.3 10269.4 10336.8 11017.4 3413.6 3460.4 3466.1 3469.3 3527.2 87211.0 88123.1 88311.9 88329.0 88581.0 9142.4 9318.9 9414.4 9540.5 9576.6 21267.8 21304.9 21357.8 21414.3 21416.9 7295.7 7406.7 7429.8 7446.0 7454.9 3560.0 4019.8 4025.2 4107.7 4129.2 3415.7 3521.6 3525.5 3590.0 3637.7 652.6 664.1 664.4 670.7 671.1 556.3 562.3 569.6 581.4 609.7 6745.9 8014.8 8047.3 8050.4 8080.1 529.0 532.2 553.5 564.9 624.0 3793.7 3826.9 3833.7 3844.9 3879.2 91005.0 91035.6 91139.0 91355.5 95572.0 71688.9 72856.0 72923.0 73467.0 76507.0 62441.0 62726.4 63033.0 63259.4 64714.4 7538.2 7616.6 7821.0 7958.0 8455.5 49015.0 50691.0 50785.0 51316.0 52194.7 71911.6 72645.6 73439.6 73673.6 75429.0 9072.7 9230.8 10588.9 10711.7 11352.6 11720.4 12040.3 12064.2 12155.3 12294.3 11503.2 11621.4 11786.0 11981.5 12008.5 11433.8 11434.0 11531.9 11558.7 11631.9 11155.4 11481.4 11618.1 11757.6 12290.9 9711.5 9711.7 9755.0 9883.3 9911.2 8931.7 8960.5 9249.9 9760.7 9875.2 03:30:52 INFO - PROCESS | 6464 | -------- Summary: end -------- 03:30:52 INFO - PROCESS | 6464 | 03:30:53 INFO - TEST-INFO | 6464: exit 0 03:30:53 INFO - TEST-OK | dromaeo_css | took 1113264ms 03:30:53 INFO - TEST-START | kraken 03:30:53 INFO - operating with platform_type : mac_ 03:30:53 INFO - Initialising browser for kraken test... 03:30:53 INFO - TEST-INFO | started process 6467 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpq3AA68/profile http://localhost:56516/getInfo.html) 03:30:55 INFO - PROCESS | 6467 | __metrics Screen width/height:1600/1200 03:30:55 INFO - PROCESS | 6467 | colorDepth:24 03:30:55 INFO - PROCESS | 6467 | Browser inner width/height: 1024/689 03:30:55 INFO - PROCESS | 6467 | __metrics 03:30:55 INFO - PROCESS | 6467 | 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" 03:30:55 INFO - PROCESS | 6467 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:30:56 INFO - TEST-INFO | 6467: exit 0 03:30:56 INFO - Browser initialized. 03:30:56 INFO - Running cycle 1/1 for kraken test... 03:30:56 INFO - TEST-INFO | started process 6470 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/T/tmpq3AA68/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:07 INFO - PROCESS | 6470 | RSS: Main: 246108160 03:31:07 INFO - PROCESS | 6470 | 03:31:10 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56516/tests/kraken/driver.html?testName=audio-beat-detection) 03:31:11 INFO - PROCESS | 6470 | RSS: Main: 292347904 03:31:11 INFO - PROCESS | 6470 | 03:31:13 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56516/tests/kraken/driver.html?testName=audio-dft) 03:31:14 INFO - PROCESS | 6470 | RSS: Main: 301146112 03:31:14 INFO - PROCESS | 6470 | 03:31:17 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56516/tests/kraken/driver.html?testName=audio-fft) 03:31:18 INFO - PROCESS | 6470 | RSS: Main: 286277632 03:31:18 INFO - PROCESS | 6470 | 03:31:20 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56516/tests/kraken/driver.html?testName=audio-oscillator) 03:31:20 INFO - PROCESS | 6470 | RSS: Main: 288772096 03:31:20 INFO - PROCESS | 6470 | 03:31:22 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56516/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:31:23 INFO - PROCESS | 6470 | RSS: Main: 291295232 03:31:23 INFO - PROCESS | 6470 | 03:31:26 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56516/tests/kraken/driver.html?testName=imaging-darkroom) 03:31:26 INFO - PROCESS | 6470 | RSS: Main: 291811328 03:31:26 INFO - PROCESS | 6470 | 03:31:29 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56516/tests/kraken/driver.html?testName=imaging-desaturate) 03:31:30 INFO - PROCESS | 6470 | RSS: Main: 290521088 03:31:30 INFO - PROCESS | 6470 | 03:31:33 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56516/tests/kraken/driver.html?testName=json-parse-financial) 03:31:33 INFO - PROCESS | 6470 | RSS: Main: 290217984 03:31:33 INFO - PROCESS | 6470 | 03:31:35 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56516/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:31:35 INFO - PROCESS | 6470 | RSS: Main: 326938624 03:31:35 INFO - PROCESS | 6470 | 03:31:37 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:31:38 INFO - PROCESS | 6470 | RSS: Main: 325554176 03:31:38 INFO - PROCESS | 6470 | 03:31:40 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:31:40 INFO - PROCESS | 6470 | RSS: Main: 331575296 03:31:40 INFO - PROCESS | 6470 | 03:31:43 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:31:43 INFO - PROCESS | 6470 | RSS: Main: 332754944 03:31:43 INFO - PROCESS | 6470 | 03:31:46 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:31:47 INFO - PROCESS | 6470 | RSS: Main: 334508032 03:31:47 INFO - PROCESS | 6470 | 03:31:48 INFO - PROCESS | 6470 | Cycle 1(1): loaded http://localhost:56516/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56516/tests/kraken/driver.html?testName=ai-astar) 03:31:49 INFO - PROCESS | 6470 | RSS: Main: 393756672 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | __start_tp_report 03:31:49 INFO - PROCESS | 6470 | _x_x_mozilla_page_load 03:31:49 INFO - PROCESS | 6470 | _x_x_mozilla_page_load_details 03:31:49 INFO - PROCESS | 6470 | |i|pagename|runs| 03:31:49 INFO - PROCESS | 6470 | |0;ai-astar;111;109;114;159;163;111;116;111;112;110 03:31:49 INFO - PROCESS | 6470 | |1;audio-beat-detection;156;120;145;159;114;141;163;120;159;107 03:31:49 INFO - PROCESS | 6470 | |2;audio-dft;185;184;185;188;184;185;185;185;182;184 03:31:49 INFO - PROCESS | 6470 | |3;audio-fft;81;72;85;77;57;57;58;81;79;75 03:31:49 INFO - PROCESS | 6470 | |4;audio-oscillator;95;104;131;81;78;84;121;78;87;155 03:31:49 INFO - PROCESS | 6470 | |5;imaging-gaussian-blur;86;115;134;125;86;83;87;83;85;83 03:31:49 INFO - PROCESS | 6470 | |6;imaging-darkroom;92;92;93;93;92;93;93;93;92;92 03:31:49 INFO - PROCESS | 6470 | |7;imaging-desaturate;86;84;87;83;86;85;86;86;84;85 03:31:49 INFO - PROCESS | 6470 | |8;json-parse-financial;56;54;53;53;53;53;54;63;56;53 03:31:49 INFO - PROCESS | 6470 | |9;json-stringify-tinderbox;68;68;70;79;71;68;68;69;68;69 03:31:49 INFO - PROCESS | 6470 | |10;stanford-crypto-aes;82;81;83;82;83;81;81;81;83;83 03:31:49 INFO - PROCESS | 6470 | |11;stanford-crypto-ccm;132;120;119;122;130;123;120;116;130;130 03:31:49 INFO - PROCESS | 6470 | |12;stanford-crypto-pbkdf2;137;138;138;136;139;137;139;137;136;138 03:31:49 INFO - PROCESS | 6470 | |13;stanford-crypto-sha256-iterative;66;66;68;67;67;65;68;66;70;83 03:31:49 INFO - PROCESS | 6470 | __end_tp_report 03:31:49 INFO - PROCESS | 6470 | __start_cc_report 03:31:49 INFO - PROCESS | 6470 | _x_x_mozilla_cycle_collect,1262 03:31:49 INFO - PROCESS | 6470 | __end_cc_report 03:31:49 INFO - PROCESS | 6470 | __startTimestamp1457523109004__endTimestamp 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | ------- Summary: start ------- 03:31:49 INFO - PROCESS | 6470 | Number of tests: 14 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#0] ai-astar Cycles:10 Average:121.60 Median:113.00 stddev:20.88 (18.5%) stddev-sans-first:21.79 03:31:49 INFO - PROCESS | 6470 | Values: 111.0 109.0 114.0 159.0 163.0 111.0 116.0 111.0 112.0 110.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:150.50 stddev:21.27 (14.1%) stddev-sans-first:21.59 03:31:49 INFO - PROCESS | 6470 | Values: 156.0 120.0 145.0 159.0 114.0 141.0 163.0 120.0 159.0 107.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.49 (0.8%) stddev-sans-first:1.58 03:31:49 INFO - PROCESS | 6470 | Values: 185.0 184.0 185.0 188.0 184.0 185.0 185.0 185.0 182.0 184.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#3] audio-fft Cycles:10 Average:72.20 Median:78.00 stddev:10.85 (13.9%) stddev-sans-first:11.03 03:31:49 INFO - PROCESS | 6470 | Values: 81.0 72.0 85.0 77.0 57.0 57.0 58.0 81.0 79.0 75.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#4] audio-oscillator Cycles:10 Average:101.40 Median:79.50 stddev:26.25 (33.0%) stddev-sans-first:27.74 03:31:49 INFO - PROCESS | 6470 | Values: 95.0 104.0 131.0 81.0 78.0 84.0 121.0 78.0 87.0 155.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:84.00 stddev:19.86 (23.6%) stddev-sans-first:20.68 03:31:49 INFO - PROCESS | 6470 | Values: 86.0 115.0 134.0 125.0 86.0 83.0 87.0 83.0 85.0 83.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#6] imaging-darkroom Cycles:10 Average:92.50 Median:93.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:31:49 INFO - PROCESS | 6470 | Values: 92.0 92.0 93.0 93.0 92.0 93.0 93.0 93.0 92.0 92.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.23 (1.4%) stddev-sans-first:1.27 03:31:49 INFO - PROCESS | 6470 | Values: 86.0 84.0 87.0 83.0 86.0 85.0 86.0 86.0 84.0 85.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.00 stddev:3.12 (5.8%) stddev-sans-first:3.28 03:31:49 INFO - PROCESS | 6470 | Values: 56.0 54.0 53.0 53.0 53.0 53.0 54.0 63.0 56.0 53.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:69.00 stddev:3.39 (4.9%) stddev-sans-first:3.54 03:31:49 INFO - PROCESS | 6470 | Values: 68.0 68.0 70.0 79.0 71.0 68.0 68.0 69.0 68.0 69.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:0.94 (1.1%) stddev-sans-first:1.00 03:31:49 INFO - PROCESS | 6470 | Values: 82.0 81.0 83.0 82.0 83.0 81.0 81.0 81.0 83.0 83.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.50 stddev:5.75 (4.5%) stddev-sans-first:5.36 03:31:49 INFO - PROCESS | 6470 | Values: 132.0 120.0 119.0 122.0 130.0 123.0 120.0 116.0 130.0 130.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.50 Median:138.00 stddev:1.08 (0.8%) stddev-sans-first:1.13 03:31:49 INFO - PROCESS | 6470 | Values: 137.0 138.0 138.0 136.0 139.0 137.0 139.0 137.0 136.0 138.0 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - PROCESS | 6470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:67.50 stddev:5.25 (7.8%) stddev-sans-first:5.49 03:31:49 INFO - PROCESS | 6470 | Values: 66.0 66.0 68.0 67.0 67.0 65.0 68.0 66.0 70.0 83.0 03:31:49 INFO - PROCESS | 6470 | -------- Summary: end -------- 03:31:49 INFO - PROCESS | 6470 | 03:31:49 INFO - TEST-INFO | 6470: exit 0 03:31:49 INFO - TEST-OK | kraken | took 56705ms 03:31:49 INFO - SUITE-END | took 1169s 03:31:50 INFO - Completed test suite (00:19:30) 03:31:50 INFO - javascript benchmark 03:31:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2729.2358139720877, 3394.1514621344663, 3418.2821607462424, 3438.879639212625, 3476.7913925164494, 5544.6395984261, 5568.303962004755, 5573.721313934302, 5585.972070139649, 5612.158176273561, 5491.258680078188, 5555.083411237151, 5559.3328800543995, 5563.554915606752, 5579.246801681772, 5037.0, 5045.596352291808, 5067.721275329855, 5159.509846564571, 5162.638615296931, 5056.544910958013, 5133.845984620468, 5150.587952963772, 5164.4060932992625, 5164.974175129119, 5050.242463630448, 5070.2141168118815, 5093.719845408501, 5112.616553758465, 5134.717590532519, 5109.4379618241965, 5128.794848206067, 5135.101357262502, 5150.768215430277, 5202.375714914235, 4983.825566105169, 5010.323606313137, 5068.113080210986, 5069.138246498104, 5106.361704786902, 4520.864374068783, 5468.070428027245, 5469.56243500519, 5481.890362192774, 5574.637648552831, 6123.173371594867, 6156.56904016719, 6165.907511387333, 6168.475679567242, 6174.259088909314, 4677.6257899367965, 6096.1770161028135, 6217.782377616807, 6219.595726277777, 6230.906536401958, 5534.1975413565615, 5534.584906132056, 5548.667079975215, 5553.194786755897, 5587.413321601214, 6134.754609815646, 6179.351168127372, 6193.969030154911, 6197.876042479215, 6202.81391558254, 5853.560982926212, 5931.584789064724, 5969.194158788508, 6061.393860613992, 6104.084387341845, 6102.350431610208, 6122.438798062313, 6126.36500017443, 6142.539309551801, 6146.354632763585, 6030.909536356959, 6031.60794548353, 6041.335453100155, 6049.001914684028, 6054.273487181566, 5960.642361458326, 6055.666938318347, 6135.69203737716, 6150.446459818638, 6156.753729850845, 4789.137955168034, 4798.2802579613335, 4798.49615790337, 4827.324174615556, 4864.36763220779, 4246.4691913510815, 4319.97840010798, 4339.067100573392, 4343.9348409773875, 4392.231359512072, 5508.807191748269, 5564.499195072382, 5601.859953501195, 5615.971920140373, 5620.100783874561, 6171.0, 6178.227721534809, 6184.134221209034, 6187.102870083812, 6188.195534580475, 5465.098258787335, 5533.723313834373, 5577.553795696415, 5584.860378490489, 5606.299212598426, 5214.400343960418, 5221.295125158055, 5274.472552744694, 5282.97358513205, 5307.867303317371, 6240.438360547572, 6245.843853903689, 6259.843503912439, 6278.811635650938, 6289.591176573416, 6031.819045428644, 6143.232095988002, 6155.230596175478, 6155.784547540994, 6160.0, 5344.919826202688, 5365.248865158803, 6197.791430670976, 6229.0, 6244.188255526752, 5981.618050635144, 6004.39956004396, 6005.1892994446935, 6061.212042434631, 6061.36355682647, 5999.100134979788, 6102.420270074336, 6137.815865524041, 6157.415045570664, 6168.475679567107, 5849.888521180962, 5856.853578660568, 5870.14882841994, 5874.5887787854435, 5876.3536011037895, 5694.373618902, 5837.766489340549, 5915.08316210988, 6014.0, 6024.487918526975, 4509.751963642031, 5740.483356497935, 5788.479036886701, 5796.449337312949, 5809.767609295581, 5974.074018527135, 5980.790672326448, 5981.7308221131025, 5996.820095397145, 5999.1901093351835, 5155.200943853709, 5684.63049901755, 5743.4256574342235, 5786.768529258951, 5794.913076303943], "unit": "score", "name": "dojo.html", "value": 5544.712375427754}, {"lowerIsBetter": false, "replicates": [443.80916206031435, 573.7749903955057, 576.1012820000799, 580.2393606851987, 639.9552031357805, 24946.0, 31039.379212415737, 31071.689283107164, 31091.222719432026, 31092.0, 31621.841890790514, 41003.58996410042, 41321.14054867531, 41438.378424323586, 41533.0, 9520.571574279174, 9727.805443891119, 9752.512374381287, 9758.560864761102, 9760.755981100458, 9587.808243835154, 9690.515474226295, 9704.0, 9724.805503889918, 9729.756756081084, 9701.223902087817, 9749.95125024374, 9762.414255144678, 9763.609455621767, 9768.560414781316, 9644.710658680251, 9873.160781333596, 9873.40759554429, 9874.358166719141, 9876.851847222333, 9632.181264592518, 9765.90234097657, 9783.90216097837, 9800.509974501247, 9800.656977005841, 41996.0, 42307.15385692269, 42318.57681423177, 42340.0, 42390.36414453786, 3153.5427363032463, 3205.1987003249187, 3326.417876871538, 3403.1662242750435, 3418.26507300929, 27987.300317492023, 28959.56560651592, 28974.275643108882, 28974.27564310909, 28984.0, 2694.582339737344, 2696.6089916961932, 2809.395979864339, 2844.431113777232, 2870.799044066916, 505804.4709776464, 505900.0, 510829.0, 511466.0, 512705.0, 64928.0, 65615.34384656188, 65827.34172658212, 65846.01230981539, 65958.67020664962, 75814.24185758182, 76250.0, 76315.61842190864, 76336.61831690917, 76372.61813691007, 14370.425182992563, 14839.777403338958, 17910.283588656308, 17990.370337038403, 18019.459416217534, 13334.333283335794, 13365.599032029055, 13398.06213565041, 13399.665008374868, 13409.597712068653, 21107.0, 22251.666225006637, 22252.0, 22257.332280031624, 22271.0, 7876.527408355517, 8282.461639993382, 9850.60597576089, 9862.654807081717, 9916.752081197883, 900.3877363392825, 989.475577943691, 1001.8497225416246, 1056.9894301057045, 1083.1713738989679, 26208.8689556551, 29379.85310073479, 29482.43022331542, 29695.0, 30199.547006794917, 951.3673407184145, 1045.2839804733783, 1109.312226419625, 1113.1984970820995, 1122.36586328724, 14178.858211417753, 14217.146971181763, 14463.915206359565, 14688.632784180481, 14798.038127521677, 522575.0, 522907.0, 523158.0, 523897.9466334676, 523959.0, 59336.703316484, 61583.38416615866, 61681.0, 61736.0, 61789.38210617926, 1314.8553659097493, 1336.832895888014, 1439.755241608929, 1450.9564713058414, 1464.5606318104526, 23839.0, 27874.721252787214, 28941.710582893902, 29317.706822931497, 29464.55803162997, 34843.477347839296, 47426.05147897092, 47472.8131796694, 47484.0, 47537.76231118822, 267642.0, 363469.0, 367049.0, 367455.0, 368598.0, 28825.711742882304, 30148.84925575358, 31767.93508421945, 33001.83499082489, 33064.50403244001, 42003.949901252716, 42296.0, 42417.36373954331, 43949.78025109854, 43978.56021439873, 35260.47109293311, 35323.58705651745, 35414.468782967764, 36044.0, 36351.636483635884, 35345.0, 36007.0998225036, 36104.27791444104, 37206.0, 37826.0, 35567.0, 35919.64080359163, 36069.819650901576, 36463.635363646026, 37272.627273728, 31895.620875824465, 33720.1569960753, 34434.0, 34779.652203478654, 34931.47602786011, 23667.52664946657, 24225.0, 24690.50618987646, 24714.382140446633, 24847.0], "unit": "score", "name": "ext.html", "value": 19623.267787617297}, {"lowerIsBetter": false, "replicates": [365.8061227549399, 372.8229091181689, 373.3298728781836, 378.0209258021723, 379.597626515893, 19866.602667946652, 20247.797522024775, 20369.796302036975, 20658.173673053097, 20762.9618519074, 19601.607967840635, 19612.0, 20174.899125504387, 20254.49363765903, 20312.085956131974, 5657.23627310313, 5804.767809287623, 5846.795362162326, 5860.882782344351, 5869.354371019184, 5598.216249725042, 5853.239078919734, 5867.239828051589, 5871.647701137924, 5877.14781356703, 5914.142449344842, 5925.259342582177, 5928.911066334009, 5943.613665111776, 5960.284765828107, 5909.320428150753, 6356.237251529823, 6452.225732912034, 6513.0, 6530.2816690164045, 5705.0, 5740.225069615632, 5744.253247077895, 5747.3103227612955, 5748.942510574882, 23442.0, 23815.951288281034, 24140.155094571604, 24921.750782492305, 24971.250862473975, 2049.5286084200716, 2130.1479408236673, 2157.7626461089426, 2199.5051113499335, 2226.25420484138, 9739.366941148874, 11477.483513241925, 13338.13302135358, 14377.353019114165, 15142.394304227817, 1751.1506919144206, 1769.9469015929542, 1792.542901560094, 1799.4691565988064, 1889.4803928919519, 105830.0, 108774.0, 110420.4478977608, 112559.06043288445, 112689.0, 11191.44042797873, 11323.207375483636, 11325.490352934137, 11335.036521895567, 11462.025727813063, 13661.795073073912, 13665.931670341584, 13743.725125497434, 13754.243516606683, 13762.0, 7067.7631414503285, 8536.914630853613, 8653.826923461496, 8762.255208307366, 8787.384883058252, 8883.689070882618, 8901.376903616685, 8903.465792052368, 8998.460092394478, 9023.187913087853, 4468.151051300242, 4545.499995000548, 4548.999220171557, 4552.658550608718, 4601.079784043205, 1840.4938641873325, 1868.7570615820127, 1880.9247630094917, 1887.3205645967441, 1893.9621207576047, 931.2829121576484, 966.7776411425411, 969.1713584884822, 989.8317286061387, 991.4051569058507, 19259.90370048141, 20070.824139974717, 20300.984950752405, 20346.898265508873, 21028.579428411347, 890.7684002159485, 971.1696499492832, 976.2092704909046, 999.1756800639502, 1034.6430481483876, 10439.478026098817, 10450.798158211903, 10495.842562361571, 10663.573457061631, 10714.839277410845, 629344.0, 635032.0, 640512.0, 641104.0, 652684.0, 115491.42254288675, 116799.0, 121964.39017804855, 122499.0, 124885.50228995369, 899.7300809757178, 1031.7979553819866, 1043.3009883378154, 1058.8200005999, 1060.16247164739, 13488.93255533716, 15353.923230383776, 17807.643847123243, 18062.187201575696, 18365.898046117276, 38167.427488587135, 53968.46031539791, 54034.729826350616, 54038.72980635072, 56120.26556813208, 75422.62288688522, 78214.608926955, 78216.60891695505, 78842.21157788349, 79542.6022869882, 7888.092869320101, 7923.819420851745, 8012.959935200287, 8038.356931445587, 8204.113053997733, 12938.676533086747, 13147.802782958071, 13328.733425331633, 13423.395947182595, 13491.595252142451, 11263.436828158723, 11435.0, 11555.8266625999, 11652.242604230698, 11690.064794816564, 9025.864612030693, 9643.517824108907, 10936.23446358779, 11097.500612472297, 11697.824532632187, 8672.0, 11508.138225239205, 11903.928646421864, 11921.0, 11943.925046745835, 7977.401694872791, 8095.352371810123, 8158.8776168356335, 8364.0, 8370.246677798783, 11070.169737269576, 11771.352575608424, 11821.113416493625, 12013.459394327101, 12060.97481714029], "unit": "score", "name": "jquery.html", "value": 9579.70703886813}, {"lowerIsBetter": false, "replicates": [1440.25106944389, 1591.2600640702074, 1628.2835552356967, 1921.7789954155276, 2045.6726923692213, 7997.800054998628, 8539.743807685763, 8667.479951202933, 8679.956600217005, 8697.565121743903, 8450.57747112645, 8732.476051436919, 8733.0, 8735.257503112243, 8757.474551526913, 2175.6627722703006, 2422.4065104049446, 2433.257856353816, 2466.1738317663603, 2484.888180031894, 2495.25142457263, 2502.5745623244093, 2504.486580251053, 2508.423062695581, 2509.8494090354548, 2425.3209101451534, 2470.0737223541173, 2485.6023036314195, 2487.452760392711, 2487.8382905111202, 2409.494006258688, 2429.4898071405028, 2441.755824417553, 2455.9263222103364, 2457.0908763757348, 2425.987870060656, 2427.599446091393, 2446.97553024471, 2449.926502204919, 2454.47228845799, 8778.561071946377, 8897.199252067345, 8902.510361930092, 8906.86639700405, 8911.598978046004, 5468.207109969072, 5564.10974244119, 5570.916436253459, 5605.971970140124, 5611.961787069365, 3567.714582833367, 3668.4497325401135, 3728.8694895678523, 3761.774293542369, 3765.849366025383, 1031.2059714020163, 1051.2378525568977, 1051.5636011055478, 1061.851340812287, 1062.0494657281768, 12198.39008049594, 12221.327826969513, 12233.327167005811, 12244.510219591206, 12263.386830658432, 4861.0, 4902.1911384621135, 4977.0, 4978.327925730053, 5008.670967999825, 10207.387556746618, 10215.0, 10223.693289201336, 10246.231532635082, 10253.692389228336, 5586.972065139648, 5591.993441180626, 5598.636088654224, 5599.972000139973, 5608.775648974077, 4461.977690111528, 4564.954350456453, 4804.855854324376, 4959.702417854868, 5013.047520971004, 3899.434581985653, 3962.6829853611644, 3981.283368993551, 4017.9196416071513, 4025.0943537703783, 1140.6349968010322, 1275.6364436135657, 1304.3543445994103, 1319.5711393797055, 1331.5738963531771, 1291.8126871603565, 1314.5399110311505, 1330.2882957617821, 1336.4587342126454, 1353.1813252982001, 8149.348052155813, 8332.458390204618, 8337.791555211046, 8350.415470916978, 8353.540555269397, 498.84286449768206, 507.1454599000622, 513.6609837507227, 518.6550943622524, 519.586724110419, 6197.938020619827, 6210.0, 6256.499480041586, 6269.059641053787, 6276.529260305495, 9499.38254013487, 10369.585216591402, 10428.687139385831, 10703.929607039234, 10852.72868178286, 10053.79892402148, 10616.840747388795, 10703.46482675863, 10708.946455267675, 10711.25021248505, 8411.873821892677, 8457.746267612105, 8503.702370417006, 8558.572071396406, 8561.914380856237, 8243.422960392714, 8278.544680042656, 8306.792330191794, 8357.122502137188, 8401.411901166859, 9561.235101191749, 9685.32202745801, 9799.608015679292, 9962.651307204504, 9981.151602113901, 9888.307818452638, 10089.0, 10243.539040743333, 10253.692389228336, 10281.794364112826, 6719.092922455601, 7318.707251710085, 7577.5453472791805, 7607.353374962969, 7709.0, 8365.205305495969, 8385.245327920517, 8424.115467875785, 8430.704925327584, 8433.0, 7249.311315425026, 7300.671469783979, 7308.707651694085, 7458.776236712907, 7490.737824176128, 6084.60450070744, 7137.393321567725, 7243.3843123333, 7296.635168241673, 7370.926290737024, 7567.886481702889, 7713.19011503784, 7723.189065148079, 7725.1502334744255, 7735.110462296683, 6919.550229235084, 7014.894776578458, 7016.193137789015, 7016.228214896255, 7021.859562808818, 6848.075509806113, 7088.184858741104, 7090.787276381717, 7091.929080709333, 7113.608751518716], "unit": "score", "name": "mootools.html", "value": 4878.093358349605}, {"lowerIsBetter": false, "replicates": [260.36471010733806, 329.49093650310266, 330.6643756587064, 336.58431836681694, 342.05251453473863, 6287.402696743808, 6515.543911926167, 6529.608223506593, 6569.277379488252, 6571.7042733077005, 6358.872822543558, 6458.967705161479, 6480.416762491375, 6492.448141907944, 6505.5120865935005, 4526.705764125321, 4608.695652173913, 4630.652701047418, 4758.095961767271, 4782.497837727041, 4675.625949924015, 4706.576408123268, 4710.97644511777, 4727.149113159629, 4741.336212930192, 4662.836800711976, 4665.09030739006, 4673.532646735333, 4688.226442636961, 4710.411198600175, 4494.16857881293, 4519.276915693474, 4645.140648979949, 4658.650601204923, 4708.929366059512, 3217.501287300472, 3945.861894833667, 3951.6641085507767, 3976.602339766029, 3981.7013723970526, 4848.709077455329, 6082.695865206766, 6143.232095988002, 6143.631382117042, 6173.753049878, 5442.809501667462, 5444.40111587725, 5451.100568406208, 5454.91817622736, 5455.345358556959, 6806.829829254259, 6806.897896531556, 6809.0, 6811.594202898551, 6818.454523638097, 4297.333913243452, 4454.465464144323, 4456.108778244332, 4481.439820022497, 4504.346869703907, 7189.496735228536, 7241.058662373857, 7298.12422509297, 7298.3066608672625, 7304.196538380774, 4531.161735079021, 4557.316402539579, 4560.224761790503, 4560.954390456053, 4567.337736028324, 3869.496965394537, 4597.931031034537, 4610.76946152691, 4621.19129152397, 4624.745638989888, 5461.371942226695, 5462.344518657707, 5470.452954704498, 5475.479829416199, 5481.698506582176, 6306.684665766693, 6661.367170118831, 6875.312468753084, 6905.447564194953, 6919.37725604698, 1494.4532408956677, 1581.351645825206, 1599.856012958816, 1602.671452352265, 1603.7915071040923, 1020.102309967239, 1030.6804890483975, 1032.7986042721598, 1039.5841663334575, 1047.8480620310013, 6256.874862502725, 6396.584222025554, 6421.422072013541, 6436.935630643728, 6437.356264373525, 6995.055667484926, 7226.0606121204955, 7229.602371869598, 7230.783076507608, 7241.89137162943, 6507.186601674791, 6515.087887695727, 6527.5430719849155, 6530.346965303432, 6531.248906375828, 3732.1789206374556, 3801.163743976321, 3805.296020236265, 3805.486259355007, 3812.5615554211067, 7264.019357386685, 7455.2172021938, 7525.134609519866, 7540.434467414966, 7546.320831125225, 7372.115346158495, 7424.294692004359, 7425.480216384909, 7429.034225550752, 7466.664000120008, 7498.812529686801, 7504.099508059068, 7505.099388073466, 7507.324340809244, 7519.812004699927, 7156.606386648784, 7167.426605871414, 7192.784216473514, 7205.747798827016, 7207.315305046012, 6130.9883869161085, 6409.230892292955, 7085.468589855678, 7128.429725621834, 7139.214686384597, 7488.288612581796, 7535.171131175457, 7552.735654252075, 7555.433342499445, 7679.3856491481665, 4510.368548403292, 4558.931616025696, 4562.338460923214, 4565.977170114128, 4570.702904311209, 7142.071530700976, 7149.285071492809, 7172.820679483055, 7177.820554486179, 7178.892316615151, 6641.767538136142, 6850.897236541556, 6900.551464154814, 6925.792226233221, 6932.688029038604, 6855.622940738108, 6906.307954551167, 6909.205441374306, 6912.0, 6914.377706006484, 6731.528792984444, 6740.9325906740305, 6743.1908171019795, 6749.055132281583, 6766.323367663391, 6876.759313424006, 6896.069030680995, 6901.689423975833, 6906.8618627626165, 6910.378065973885, 6516.348365163446, 6522.706478208397, 6597.670116494252, 6669.266380698023, 6768.323167683192], "unit": "score", "name": "prototype.html", "value": 5023.733892323763}, {"lowerIsBetter": false, "replicates": [664.0636702249826, 683.3644710419314, 706.6078326528777, 763.5456903142629, 768.5081547809402, 17671.823281767178, 18026.0, 18062.5484362891, 18092.276308947625, 18099.18553665085, 15110.791136709064, 15114.0, 15237.314320855588, 15254.694906101871, 15276.0, 741.2994719989612, 750.2909750285982, 781.3475747750635, 939.4785893828939, 962.1052421248237, 942.2462030375706, 950.1591091883664, 951.4861974533743, 952.2429668413594, 953.2897990996718, 1016.6543375252413, 1017.7252141921676, 1017.9745506362364, 1019.4851599942056, 1019.8929112443197, 775.8215610409609, 780.9648565814553, 787.582581231948, 788.2432864450135, 1007.3301254665638, 725.7459889038847, 740.5223630758185, 741.2180149941863, 745.4967896669726, 745.4967896669781, 15378.461753838563, 15429.768553471595, 15458.768118478232, 15463.226838658022, 15468.0, 12432.254064756144, 12528.060395470377, 12579.597141000668, 12839.679008024781, 12883.742325153444, 10076.949615251877, 10193.337433066827, 10269.435181065039, 10336.844947325797, 11017.394043327613, 3413.5562376891094, 3460.446328587439, 3466.098814308298, 3469.3234819210265, 3527.224010717638, 87211.0, 88123.11876881277, 88311.93504519622, 88329.0, 88580.99999999936, 9142.360034797633, 9318.90681093194, 9414.435133891988, 9540.475273859865, 9576.616935322509, 21267.78732212658, 21304.893475532834, 21357.78642213558, 21414.25050123238, 21416.892915535635, 7295.744648937261, 7406.666699998513, 7429.814254643569, 7446.032015838015, 7454.85090298191, 3559.964400356015, 4019.7588144711412, 4025.1748391579654, 4107.650849677811, 4129.236091323115, 3415.692587667122, 3521.5950165730756, 3525.541679581638, 3590.0, 3637.690796282293, 652.6214795418646, 664.1333060356185, 664.3854434647932, 670.6814263224929, 671.1308855032744, 556.3435146527056, 562.3364429972671, 569.6126633888995, 581.3809285228816, 609.7195290166485, 6745.898811517831, 8014.839703205903, 8047.275745182962, 8050.355971522381, 8080.070791858894, 528.9629725919226, 532.2149829002191, 553.4714347797843, 564.8983183027012, 623.9642193958008, 3793.734438589272, 3826.9234615307537, 3833.654971052563, 3844.9231015379537, 3879.2241551689776, 91005.0, 91035.63446548308, 91139.0, 91355.54322228346, 95572.0, 71688.92466613006, 72856.0, 72923.0, 73467.0, 76507.0, 62441.0, 62726.37273627205, 63033.0, 63259.367406326266, 64714.35285647177, 7538.170801211972, 7616.5810880399895, 7821.022372203474, 7957.960210199143, 8455.450395724258, 49015.019699605095, 50691.0, 50785.0, 51315.97368052693, 52194.739026304625, 71911.64044179746, 72645.6367718158, 73439.63280183564, 73673.6316318415, 75429.0, 9072.673511537854, 9230.815383692154, 10588.894111058791, 10711.732206694895, 11352.602658906899, 11720.413979301171, 12040.337781422106, 12064.215825971283, 12155.270683759003, 12294.262344259372, 11503.194776365573, 11621.418929053683, 11786.002009090378, 11981.460834262305, 12008.459619317326, 11433.771324573296, 11434.028107610946, 11531.88468115308, 11558.653240402802, 11631.88368116308, 11155.442227888736, 11481.425928703698, 11618.128640352177, 11757.588484403004, 12290.938545307215, 9711.465869377253, 9711.708648740549, 9755.0, 9883.308168428428, 9911.207103431563, 8931.73204803857, 8960.507172105597, 9249.907500925174, 9760.69210911884, 9875.20998320147], "unit": "score", "name": "yui.html", "value": 6926.821669700754}], "name": "dromaeo_css", "value": 7492.755910988211}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 114.0, 159.0, 163.0, 111.0, 116.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 121.6}, {"lowerIsBetter": true, "replicates": [156.0, 120.0, 145.0, 159.0, 114.0, 141.0, 163.0, 120.0, 159.0, 107.0], "unit": "score", "name": "audio-beat-detection", "value": 138.4}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 185.0, 188.0, 184.0, 185.0, 185.0, 185.0, 182.0, 184.0], "unit": "score", "name": "audio-dft", "value": 184.7}, {"lowerIsBetter": true, "replicates": [81.0, 72.0, 85.0, 77.0, 57.0, 57.0, 58.0, 81.0, 79.0, 75.0], "unit": "score", "name": "audio-fft", "value": 72.2}, {"lowerIsBetter": true, "replicates": [95.0, 104.0, 131.0, 81.0, 78.0, 84.0, 121.0, 78.0, 87.0, 155.0], "unit": "score", "name": "audio-oscillator", "value": 101.4}, {"lowerIsBetter": true, "replicates": [86.0, 115.0, 134.0, 125.0, 86.0, 83.0, 87.0, 83.0, 85.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.7}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.5}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 87.0, 83.0, 86.0, 85.0, 86.0, 86.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 63.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 79.0, 71.0, 68.0, 68.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.8}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 83.0, 82.0, 83.0, 81.0, 81.0, 81.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.0}, {"lowerIsBetter": true, "replicates": [132.0, 120.0, 119.0, 122.0, 130.0, 123.0, 120.0, 116.0, 130.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [137.0, 138.0, 138.0, 136.0, 139.0, 137.0, 139.0, 137.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.5}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 67.0, 67.0, 65.0, 68.0, 66.0, 70.0, 83.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1429.6}]} 03:31:50 INFO - Return code: 0 03:31:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:31:50 INFO - # TBPL SUCCESS # 03:31:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:31:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:31:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:31:50 INFO - 2016-03-09 03:31:50.268 screenresolution[6476:109257] starting screenresolution argv=screenresolution get 03:31:50 INFO - 2016-03-09 03:31:50.270 screenresolution[6476:109257] Display 0: 1600x1200x32@60 03:31:50 INFO - 2016-03-09 03:31:50.277 screenresolution[6477:109259] starting screenresolution argv=screenresolution list 03:31:50 INFO - Available Modes on Display 0 03:31:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:31:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:31:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:31:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:31:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:31:50 INFO - Intel Iris: 03:31:50 INFO - Chipset Model: Intel Iris 03:31:50 INFO - Type: GPU 03:31:50 INFO - Bus: Built-In 03:31:50 INFO - VRAM (Dynamic, Max): 1536 MB 03:31:50 INFO - Vendor: Intel (0x8086) 03:31:50 INFO - Device ID: 0x0a2e 03:31:50 INFO - Revision ID: 0x0009 03:31:50 INFO - Displays: 03:31:50 INFO - Display: 03:31:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:31:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:31:50 INFO - Display Serial Number: 1600x1200 60 03:31:50 INFO - Main Display: Yes 03:31:50 INFO - Mirror: Off 03:31:50 INFO - Online: Yes 03:31:50 INFO - Rotation: Supported 03:31:50 INFO - Return code: 0 03:31:50 INFO - Running post-action listener: _resource_record_post_action 03:31:50 INFO - Running post-run listener: _resource_record_post_run 03:31:51 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 2949120; Write bytes: 706358272; Read time: 49; Write time: 1937 03:31:51 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 394701312; Write bytes: 388564480; Read time: 30039; Write time: 732 03:31:51 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 2949120; Write bytes: 301905408; Read time: 49; Write time: 1164 03:31:51 INFO - Running post-run listener: _upload_blobber_files 03:31:51 INFO - Blob upload gear active. 03:31:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:31:51 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 03:31:51 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'] 03:31:51 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 03:31:51 INFO - (blobuploader) - INFO - Open directory for files ... 03:31:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:31:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:31:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:52 INFO - (blobuploader) - INFO - Done attempting. 03:31:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:31:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:31:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:31:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:31:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:31:53 INFO - (blobuploader) - INFO - Done attempting. 03:31:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:31:53 INFO - Return code: 0 03:31:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:31:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:31:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb42a708d698b61a6b38466b8a51f08b4fd3cca8348a81338e2ba6db05baec80e3ecceef4530b1e16e63be11cebd21753c086bd16862d4a465ad86e6a362fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55b4577fe441d0f3734824446dcdd70fa944b06fab153a1737521b5ca58360949f0685ea51a87f3d67fb4943294f6077a4468fe1e869885efe43a7f179317e2"} 03:31:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:31:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:31:53 INFO - Contents: 03:31:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abb42a708d698b61a6b38466b8a51f08b4fd3cca8348a81338e2ba6db05baec80e3ecceef4530b1e16e63be11cebd21753c086bd16862d4a465ad86e6a362fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55b4577fe441d0f3734824446dcdd70fa944b06fab153a1737521b5ca58360949f0685ea51a87f3d67fb4943294f6077a4468fe1e869885efe43a7f179317e2"} 03:31:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:31:53 INFO - Copying logs to upload dir... 03:31:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:31:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.291916 ========= master_lag: 964.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 37 mins, 4 secs) (at 2016-03-09 03:47:57.969909) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 mins, 53 secs) (at 2016-03-09 03:47:57.977124) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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/abb42a708d698b61a6b38466b8a51f08b4fd3cca8348a81338e2ba6db05baec80e3ecceef4530b1e16e63be11cebd21753c086bd16862d4a465ad86e6a362fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55b4577fe441d0f3734824446dcdd70fa944b06fab153a1737521b5ca58360949f0685ea51a87f3d67fb4943294f6077a4468fe1e869885efe43a7f179317e2"} build_url:https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/bXR48lozTVmIApf7GIRhJA/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/abb42a708d698b61a6b38466b8a51f08b4fd3cca8348a81338e2ba6db05baec80e3ecceef4530b1e16e63be11cebd21753c086bd16862d4a465ad86e6a362fa6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55b4577fe441d0f3734824446dcdd70fa944b06fab153a1737521b5ca58360949f0685ea51a87f3d67fb4943294f6077a4468fe1e869885efe43a7f179317e2"}' ========= master_lag: 173.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 mins, 53 secs) (at 2016-03-09 03:50:51.532968) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 mins, 57 secs) (at 2016-03-09 03:50:51.533365) ========= 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.vjCxbkNaox/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.KCbL18E7MG/Listeners TMPDIR=/var/folders/d3/4p5wz9j115375p40z2tqr49w00000w/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.005186 ========= master_lag: 177.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 mins, 57 secs) (at 2016-03-09 03:53:48.583767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 03:53:48.584110) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-09 03:53:49.241097) ========= ========= Total master_lag: 1340.93 =========