builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0103 starttime: 1460464452.89 results: success (0) buildid: 20160412030235 builduid: fb8da79dcd654363a8f20d6138654dd4 revision: 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.893119) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.893645) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.893943) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005294 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.920448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.920891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.939076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.939717) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005473 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.991254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.991916) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.992670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:12.993342) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-12 05:34:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.84M=0.001s 2016-04-12 05:34:13 (8.84 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:13.107723) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:13.108087) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.026084 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:13.155986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 05:34:13.156370) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 --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 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-12 05:34:13,224 truncating revision to first 12 chars 2016-04-12 05:34:13,224 Setting DEBUG logging. 2016-04-12 05:34:13,224 attempt 1/10 2016-04-12 05:34:13,224 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/21bf1af375c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 05:34:14,181 unpacking tar archive at: mozilla-central-21bf1af375c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.209834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-12 05:34:14.386880) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:14.387712) ========= echo 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'21bf1af375c1fa8565ae3bb2e89bd1a0809363d4'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 program finished with exit code 0 elapsedTime=0.004668 script_repo_revision: '21bf1af375c1fa8565ae3bb2e89bd1a0809363d4' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:14.444620) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:14.444996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:34:14.462359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-12 05:34:14.462697) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:14 INFO - MultiFileLogger online at 20160412 05:34:14 in /builds/slave/test 05:34:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:34:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:34:14 INFO - {'append_to_log': False, 05:34:14 INFO - 'base_work_dir': '/builds/slave/test', 05:34:14 INFO - 'blob_upload_branch': 'Firefox', 05:34:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:34:14 INFO - 'branch': 'Firefox', 05:34:14 INFO - 'buildbot_json_path': 'buildprops.json', 05:34:14 INFO - 'config_files': ('talos/mac_config.py',), 05:34:14 INFO - 'default_actions': ('clobber', 05:34:14 INFO - 'read-buildbot-config', 05:34:14 INFO - 'download-and-extract', 05:34:14 INFO - 'populate-webroot', 05:34:14 INFO - 'create-virtualenv', 05:34:14 INFO - 'install', 05:34:14 INFO - 'run-tests'), 05:34:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:34:14 INFO - 'download_minidump_stackwalk': True, 05:34:14 INFO - 'download_symbols': 'ondemand', 05:34:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:34:14 INFO - 'tooltool.py': '/tools/tooltool.py', 05:34:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:34:14 INFO - '/tools/misc-python/virtualenv.py')}, 05:34:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:34:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:34:14 INFO - 'installer_path': 'installer.exe', 05:34:14 INFO - 'log_level': 'info', 05:34:14 INFO - 'log_name': 'talos', 05:34:14 INFO - 'log_to_console': True, 05:34:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:34:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:34:14 INFO - 'opt_config_files': (), 05:34:14 INFO - 'pip_index': False, 05:34:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:14 INFO - 'cmd': ('bash', 05:34:14 INFO - '-c', 05:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:14 INFO - 'enabled': True, 05:34:14 INFO - 'halt_on_failure': False, 05:34:14 INFO - 'name': 'check_screen_resolution'},), 05:34:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:34:14 INFO - 'cmd': ('bash', 05:34:14 INFO - '-c', 05:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:34:14 INFO - 'enabled': True, 05:34:14 INFO - 'halt_on_failure': False, 05:34:14 INFO - 'name': 'check_screen_resolution'},), 05:34:14 INFO - 'run_cmd_checks_enabled': True, 05:34:14 INFO - 'sps_profile': False, 05:34:14 INFO - 'sps_profile_interval': 0, 05:34:14 INFO - 'suite': 'dromaeojs-e10s', 05:34:14 INFO - 'system_bits': '32', 05:34:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:34:14 INFO - 'title': 't-yosemite-r7-0103', 05:34:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:34:14 INFO - 'use_talos_json': True, 05:34:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:34:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:34:14 INFO - 'work_dir': 'build'} 05:34:14 INFO - ##### 05:34:14 INFO - ##### Running clobber step. 05:34:14 INFO - ##### 05:34:14 INFO - Running pre-action listener: _resource_record_pre_action 05:34:14 INFO - Running main action method: clobber 05:34:14 INFO - rmtree: /builds/slave/test/build 05:34:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:34:16 INFO - Running post-action listener: _resource_record_post_action 05:34:16 INFO - ##### 05:34:16 INFO - ##### Running read-buildbot-config step. 05:34:16 INFO - ##### 05:34:16 INFO - Running pre-action listener: _resource_record_pre_action 05:34:16 INFO - Running main action method: read_buildbot_config 05:34:16 INFO - Using buildbot properties: 05:34:16 INFO - { 05:34:16 INFO - "project": "", 05:34:16 INFO - "product": "firefox", 05:34:16 INFO - "script_repo_revision": "production", 05:34:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:34:16 INFO - "repository": "", 05:34:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:34:16 INFO - "buildid": "20160412030235", 05:34:16 INFO - "stage_platform": "macosx64", 05:34:16 INFO - "basedir": "/builds/slave/test", 05:34:16 INFO - "nightly_build": "True", 05:34:16 INFO - "buildnumber": 234, 05:34:16 INFO - "slavename": "t-yosemite-r7-0103", 05:34:16 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:34:16 INFO - "platform": "yosemite_r7", 05:34:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:34:16 INFO - "branch": "mozilla-central", 05:34:16 INFO - "repo_path": "mozilla-central", 05:34:16 INFO - "revision": "21bf1af375c1fa8565ae3bb2e89bd1a0809363d4", 05:34:16 INFO - "pgo_build": "False", 05:34:16 INFO - "builduid": "fb8da79dcd654363a8f20d6138654dd4", 05:34:16 INFO - "slavebuilddir": "test" 05:34:16 INFO - } 05:34:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:34:16 INFO - Running post-action listener: _resource_record_post_action 05:34:16 INFO - ##### 05:34:16 INFO - ##### Running download-and-extract step. 05:34:16 INFO - ##### 05:34:16 INFO - Running pre-action listener: _resource_record_pre_action 05:34:16 INFO - Running main action method: download_and_extract 05:34:16 INFO - mkdir: /builds/slave/test/build/tests 05:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:16 INFO - https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:34:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:34:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:34:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:17 INFO - Downloaded 1199 bytes. 05:34:17 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:34:17 INFO - Using the following test package requirements: 05:34:17 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:34:17 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:34:17 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:34:17 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'jsshell-mac.zip'], 05:34:17 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:34:17 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:34:17 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:34:17 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:34:17 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:34:17 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:34:17 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:34:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:17 INFO - https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:34:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:34:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:34:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:19 INFO - Downloaded 18018903 bytes. 05:34:19 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'] 05:34:19 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 05:34:22 INFO - Return code: 0 05:34:22 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 05:34:22 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')]} 05:34:22 INFO - https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:34:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:34:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:34:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:23 INFO - Downloaded 18018903 bytes. 05:34:23 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'] 05:34:23 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 05:34:27 INFO - Return code: 0 05:34:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:27 INFO - https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:34:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:34:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:34:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:28 INFO - Downloaded 10841046 bytes. 05:34:28 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'] 05:34:28 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 05:34:28 INFO - Return code: 0 05:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:28 INFO - https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:34:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:34:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:34:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:34:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/arQDauJ2S7Cii_l4E_7FAg/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 05:34:32 INFO - Downloaded 108933227 bytes. 05:34:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:34:32 INFO - mkdir: /builds/slave/test/properties 05:34:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:34:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:34:32 INFO - Contents: 05:34:32 INFO - build_url:https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:34:33 INFO - Running post-action listener: _resource_record_post_action 05:34:33 INFO - Running post-action listener: set_extra_try_arguments 05:34:33 INFO - ##### 05:34:33 INFO - ##### Running populate-webroot step. 05:34:33 INFO - ##### 05:34:33 INFO - Running pre-action listener: _resource_record_pre_action 05:34:33 INFO - Running main action method: populate_webroot 05:34:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:34:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:34:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:34:33 INFO - '--tppagecycles', 05:34:33 INFO - '7'], 05:34:33 INFO - 'tests': ['tsvgm']}}, 05:34:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:34:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:34:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:34:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:34:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:34:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['damp', 'tps']}, 05:34:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'tests': ['damp', 'tps']}, 05:34:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['dromaeo_dom']}, 05:34:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:34:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['a11yr', 05:34:33 INFO - 'ts_paint', 05:34:33 INFO - 'tpaint', 05:34:33 INFO - 'sessionrestore', 05:34:33 INFO - 'sessionrestore_no_auto_restore', 05:34:33 INFO - 'tabpaint']}, 05:34:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['tsvgx', 05:34:33 INFO - 'tsvgr_opacity', 05:34:33 INFO - 'tart', 05:34:33 INFO - 'tscrollx', 05:34:33 INFO - 'cart']}, 05:34:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:34:33 INFO - 'tsvgr_opacity', 05:34:33 INFO - 'tart', 05:34:33 INFO - 'tscrollx', 05:34:33 INFO - 'cart']}, 05:34:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'talos_options': ['--disable-e10s'], 05:34:33 INFO - 'tests': ['tp5o']}, 05:34:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'tests': ['tp5o']}, 05:34:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'talos_options': ['--disable-e10s', 05:34:33 INFO - '--xperf_path', 05:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:33 INFO - 'tests': ['tp5n']}, 05:34:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:34:33 INFO - 'talos_options': ['--xperf_path', 05:34:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:34:33 INFO - 'tests': ['tp5n']}}, 05:34:33 INFO - 'talos.zip': {'path': '', 05:34:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:34:33 INFO - Running post-action listener: _resource_record_post_action 05:34:33 INFO - ##### 05:34:33 INFO - ##### Running create-virtualenv step. 05:34:33 INFO - ##### 05:34:33 INFO - Running pre-action listener: _resource_record_pre_action 05:34:33 INFO - Running main action method: create_virtualenv 05:34:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:34:33 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 05:34:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:34:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:34:33 INFO - Using real prefix '/tools/python27' 05:34:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:34:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:34:37 INFO - Installing pip.................done. 05:34:37 INFO - Return code: 0 05:34:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:34:37 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')]} 05:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:37 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')]} 05:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:37 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:37 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 05:34:37 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 05:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:37 INFO - 'HOME': '/Users/cltbld', 05:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:37 INFO - 'LOGNAME': 'cltbld', 05:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:37 INFO - 'MOZ_NO_REMOTE': '1', 05:34:37 INFO - 'NO_EM_RESTART': '1', 05:34:37 INFO - 'PAGER': '/bin/cat', 05:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:37 INFO - 'PWD': '/builds/slave/test', 05:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:37 INFO - 'SHELL': '/bin/bash', 05:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:37 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:37 INFO - 'USER': 'cltbld', 05:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:37 INFO - 'XPC_FLAGS': '0x0', 05:34:37 INFO - 'XPC_SERVICE_NAME': '0', 05:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:37 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 05:34:37 INFO - Cleaning up... 05:34:37 INFO - Return code: 0 05:34:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:34:37 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')]} 05:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:37 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')]} 05:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:37 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:37 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 05:34:37 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 05:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:37 INFO - 'HOME': '/Users/cltbld', 05:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:37 INFO - 'LOGNAME': 'cltbld', 05:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:37 INFO - 'MOZ_NO_REMOTE': '1', 05:34:37 INFO - 'NO_EM_RESTART': '1', 05:34:37 INFO - 'PAGER': '/bin/cat', 05:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:37 INFO - 'PWD': '/builds/slave/test', 05:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:37 INFO - 'SHELL': '/bin/bash', 05:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:37 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:37 INFO - 'USER': 'cltbld', 05:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:37 INFO - 'XPC_FLAGS': '0x0', 05:34:37 INFO - 'XPC_SERVICE_NAME': '0', 05:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:38 INFO - Downloading/unpacking psutil>=0.7.1 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:34:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:40 INFO - Installing collected packages: psutil 05:34:40 INFO - Running setup.py install for psutil 05:34:41 INFO - building 'psutil._psutil_osx' extension 05:34:41 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 05:34:41 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 05:34:41 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 05:34:41 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 05:34:41 INFO - building 'psutil._psutil_posix' extension 05:34:41 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 05:34:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:34:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:34:41 INFO - ^ 05:34:41 INFO - 1 warning generated. 05:34:41 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 05:34:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:34:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:34:42 INFO - Successfully installed psutil 05:34:42 INFO - Cleaning up... 05:34:42 INFO - Return code: 0 05:34:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:34:42 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')]} 05:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:42 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')]} 05:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:42 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:42 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 05:34:42 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 05:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:42 INFO - 'HOME': '/Users/cltbld', 05:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:42 INFO - 'LOGNAME': 'cltbld', 05:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:42 INFO - 'MOZ_NO_REMOTE': '1', 05:34:42 INFO - 'NO_EM_RESTART': '1', 05:34:42 INFO - 'PAGER': '/bin/cat', 05:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:42 INFO - 'PWD': '/builds/slave/test', 05:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:42 INFO - 'SHELL': '/bin/bash', 05:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:42 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:42 INFO - 'USER': 'cltbld', 05:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:42 INFO - 'XPC_FLAGS': '0x0', 05:34:42 INFO - 'XPC_SERVICE_NAME': '0', 05:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34: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 05:34:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:34:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:34:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:34:44 INFO - Installing collected packages: mozsystemmonitor 05:34:44 INFO - Running setup.py install for mozsystemmonitor 05:34:45 INFO - Successfully installed mozsystemmonitor 05:34:45 INFO - Cleaning up... 05:34:45 INFO - Return code: 0 05:34:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:45 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:45 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 05:34:45 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 05:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:45 INFO - 'HOME': '/Users/cltbld', 05:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:45 INFO - 'LOGNAME': 'cltbld', 05:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:45 INFO - 'MOZ_NO_REMOTE': '1', 05:34:45 INFO - 'NO_EM_RESTART': '1', 05:34:45 INFO - 'PAGER': '/bin/cat', 05:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:45 INFO - 'PWD': '/builds/slave/test', 05:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:45 INFO - 'SHELL': '/bin/bash', 05:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:45 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:45 INFO - 'USER': 'cltbld', 05:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:45 INFO - 'XPC_FLAGS': '0x0', 05:34:45 INFO - 'XPC_SERVICE_NAME': '0', 05:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:34:45 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 05:34:45 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 05:34:45 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 05:34:45 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 05:34:45 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 05:34:45 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 05:34:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:34:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:34:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:34:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:48 INFO - Downloading docopt-0.6.1.tar.gz 05:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:34:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:34:49 INFO - Running setup.py install for blobuploader 05:34:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:34:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:34:49 INFO - Running setup.py install for requests 05:34:49 INFO - Running setup.py install for docopt 05:34:49 INFO - Successfully installed blobuploader requests docopt 05:34:49 INFO - Cleaning up... 05:34:49 INFO - Return code: 0 05:34:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:49 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:49 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 05:34:49 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 05:34:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:49 INFO - 'HOME': '/Users/cltbld', 05:34:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:49 INFO - 'LOGNAME': 'cltbld', 05:34:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:49 INFO - 'MOZ_NO_REMOTE': '1', 05:34:49 INFO - 'NO_EM_RESTART': '1', 05:34:49 INFO - 'PAGER': '/bin/cat', 05:34:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:49 INFO - 'PWD': '/builds/slave/test', 05:34:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:49 INFO - 'SHELL': '/bin/bash', 05:34:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:49 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:49 INFO - 'USER': 'cltbld', 05:34:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:49 INFO - 'XPC_FLAGS': '0x0', 05:34:49 INFO - 'XPC_SERVICE_NAME': '0', 05:34:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HzjNUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-LB9cN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-CIaSvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-YUAnVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-npmxdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Ot1WGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-W7hMYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Hy6Gw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:50 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-3A3e2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-qLLVDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-tnkVzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-DweCGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-7OFerS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4dmDKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_dM2wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-YzpMV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:51 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-eA0dGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:34:51 INFO - Running setup.py install for manifestparser 05:34:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:34:52 INFO - Running setup.py install for mozcrash 05:34:52 INFO - Running setup.py install for mozdebug 05:34:52 INFO - Running setup.py install for mozdevice 05:34:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:34:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:34:52 INFO - Running setup.py install for mozfile 05:34:52 INFO - Running setup.py install for mozhttpd 05:34:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:34:52 INFO - Running setup.py install for mozinfo 05:34:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:34:52 INFO - Running setup.py install for mozInstall 05:34:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Running setup.py install for mozleak 05:34:53 INFO - Running setup.py install for mozlog 05:34:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Running setup.py install for moznetwork 05:34:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Running setup.py install for mozprocess 05:34:53 INFO - Running setup.py install for mozprofile 05:34:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:34:53 INFO - Running setup.py install for mozrunner 05:34:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:34:54 INFO - Running setup.py install for mozscreenshot 05:34:54 INFO - Running setup.py install for moztest 05:34:54 INFO - Running setup.py install for mozversion 05:34:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:34:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:34:54 INFO - Cleaning up... 05:34:54 INFO - Return code: 0 05:34:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34: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')]} 05:34:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34: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')]} 05:34:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:54 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:54 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 05:34:54 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 05:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:54 INFO - 'HOME': '/Users/cltbld', 05:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:54 INFO - 'LOGNAME': 'cltbld', 05:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:54 INFO - 'MOZ_NO_REMOTE': '1', 05:34:54 INFO - 'NO_EM_RESTART': '1', 05:34:54 INFO - 'PAGER': '/bin/cat', 05:34:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:54 INFO - 'PWD': '/builds/slave/test', 05:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:54 INFO - 'SHELL': '/bin/bash', 05:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:54 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:54 INFO - 'USER': 'cltbld', 05:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:54 INFO - 'XPC_FLAGS': '0x0', 05:34:54 INFO - 'XPC_SERVICE_NAME': '0', 05:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:34:54 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-K17oMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:34:54 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)) 05:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:34:54 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-RSUMIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:34:54 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)) 05:34:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:34:54 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-W2Z_P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-yNJslN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-CPUzpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-V5BNSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-fredH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-l6hFXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-TMBd__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-OpwiGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-S3cB9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:34:55 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)) 05:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:34:55 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-njUtxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:34:56 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)) 05:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:34:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-JaUKYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:34:56 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)) 05:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:34:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-gIDDdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:34:56 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)) 05:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MydlMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:34:56 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)) 05:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:34:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-48VWeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:34:56 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)) 05:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:34:56 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-8KIkng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:34:56 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)) 05:34:56 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)) 05:34:56 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)) 05:34:56 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)) 05:34:56 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)) 05:34:56 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)) 05:34:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:34:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:34:58 INFO - Downloading blessings-1.6.tar.gz 05:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:34:59 INFO - Installing collected packages: blessings 05:34:59 INFO - Running setup.py install for blessings 05:34:59 INFO - Successfully installed blessings 05:34:59 INFO - Cleaning up... 05:34:59 INFO - Return code: 0 05:34:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:34:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:34:59 INFO - Reading from file tmpfile_stdout 05:34:59 INFO - Current package versions: 05:34:59 INFO - blessings == 1.6 05:34:59 INFO - blobuploader == 1.2.4 05:34:59 INFO - docopt == 0.6.1 05:34:59 INFO - manifestparser == 1.1 05:34:59 INFO - mozInstall == 1.12 05:34:59 INFO - mozcrash == 0.17 05:34:59 INFO - mozdebug == 0.1 05:34:59 INFO - mozdevice == 0.48 05:34:59 INFO - mozfile == 1.2 05:34:59 INFO - mozhttpd == 0.7 05:34:59 INFO - mozinfo == 0.9 05:34:59 INFO - mozleak == 0.1 05:34:59 INFO - mozlog == 3.1 05:34:59 INFO - moznetwork == 0.27 05:34:59 INFO - mozprocess == 0.22 05:34:59 INFO - mozprofile == 0.28 05:34:59 INFO - mozrunner == 6.11 05:34:59 INFO - mozscreenshot == 0.1 05:34:59 INFO - mozsystemmonitor == 0.0 05:34:59 INFO - moztest == 0.7 05:34:59 INFO - mozversion == 1.4 05:34:59 INFO - psutil == 3.1.1 05:34:59 INFO - requests == 1.2.3 05:34:59 INFO - wsgiref == 0.1.2 05:34:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:34:59 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')]} 05:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:59 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')]} 05:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:59 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:59 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 05:34:59 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 05:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:59 INFO - 'HOME': '/Users/cltbld', 05:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:59 INFO - 'LOGNAME': 'cltbld', 05:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:59 INFO - 'MOZ_NO_REMOTE': '1', 05:34:59 INFO - 'NO_EM_RESTART': '1', 05:34:59 INFO - 'PAGER': '/bin/cat', 05:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:59 INFO - 'PWD': '/builds/slave/test', 05:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:59 INFO - 'SHELL': '/bin/bash', 05:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:59 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:59 INFO - 'USER': 'cltbld', 05:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:59 INFO - 'XPC_FLAGS': '0x0', 05:34:59 INFO - 'XPC_SERVICE_NAME': '0', 05:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 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)) 05:34:59 INFO - Cleaning up... 05:34:59 INFO - Return code: 0 05:34:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:34:59 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')]} 05:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:59 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')]} 05:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:34:59 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:34:59 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 05:34:59 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 05:34:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:34:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:59 INFO - 'HOME': '/Users/cltbld', 05:34:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:59 INFO - 'LOGNAME': 'cltbld', 05:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:59 INFO - 'MOZ_NO_REMOTE': '1', 05:34:59 INFO - 'NO_EM_RESTART': '1', 05:34:59 INFO - 'PAGER': '/bin/cat', 05:34:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:59 INFO - 'PWD': '/builds/slave/test', 05:34:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:59 INFO - 'SHELL': '/bin/bash', 05:34:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:34:59 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:34:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:59 INFO - 'USER': 'cltbld', 05:34:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:59 INFO - 'XPC_FLAGS': '0x0', 05:34:59 INFO - 'XPC_SERVICE_NAME': '0', 05:34:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:00 INFO - Downloading/unpacking jsonschema 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:00 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 05:35:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:35:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:35:03 INFO - warning: no files found matching '*.txt' 05:35:03 INFO - no previously-included directories found matching 'build' 05:35:03 INFO - no previously-included directories found matching 'dist' 05:35:03 INFO - no previously-included directories found matching '.git*' 05:35:03 INFO - Installing collected packages: jsonschema, functools32 05:35:03 INFO - Running setup.py install for functools32 05:35:03 INFO - warning: no files found matching '*.txt' 05:35:03 INFO - no previously-included directories found matching 'build' 05:35:03 INFO - no previously-included directories found matching 'dist' 05:35:03 INFO - no previously-included directories found matching '.git*' 05:35:03 INFO - Successfully installed jsonschema functools32 05:35:03 INFO - Cleaning up... 05:35:03 INFO - Return code: 0 05:35:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:03 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 0x10c1cda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1dd420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf00557bf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, '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.oekLaku1nf/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.OI09c984nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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 05:35:03 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 05:35:03 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 05:35:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:35:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:03 INFO - 'HOME': '/Users/cltbld', 05:35:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:03 INFO - 'LOGNAME': 'cltbld', 05:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:03 INFO - 'MOZ_NO_REMOTE': '1', 05:35:03 INFO - 'NO_EM_RESTART': '1', 05:35:03 INFO - 'PAGER': '/bin/cat', 05:35:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:03 INFO - 'PWD': '/builds/slave/test', 05:35:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:03 INFO - 'SHELL': '/bin/bash', 05:35:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:35:03 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:35:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:03 INFO - 'USER': 'cltbld', 05:35:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:03 INFO - 'XPC_FLAGS': '0x0', 05:35:03 INFO - 'XPC_SERVICE_NAME': '0', 05:35:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:03 INFO - Downloading/unpacking flake8 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:03 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 05:35:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:35:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:35:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:06 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 05:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:35:07 INFO - no previously-included directories found matching 'docs/_build' 05:35:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:35:07 INFO - Running setup.py install for pep8 05:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:35:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:35:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:35:07 INFO - no previously-included directories found matching 'docs/_build' 05:35:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:35:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:35:07 INFO - Cleaning up... 05:35:07 INFO - Return code: 0 05:35:07 INFO - Running post-action listener: _resource_record_post_action 05:35:07 INFO - Running post-action listener: _start_resource_monitoring 05:35:07 INFO - Starting resource monitoring. 05:35:07 INFO - ##### 05:35:07 INFO - ##### Running install step. 05:35:07 INFO - ##### 05:35:07 INFO - Running pre-action listener: _resource_record_pre_action 05:35:07 INFO - Running main action method: install 05:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:35:07 INFO - Reading from file tmpfile_stdout 05:35:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:35:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:35:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:35:07 INFO - Reading from file tmpfile_stdout 05:35:07 INFO - Output received: 05:35:07 INFO - Usage: mozinstall [options] installer 05:35:07 INFO - Options: 05:35:07 INFO - -h, --help show this help message and exit 05:35:07 INFO - -d DEST, --destination=DEST 05:35:07 INFO - Directory to install application into. [default: 05:35:07 INFO - "/builds/slave/test"] 05:35:07 INFO - --app=APP Application being installed. [default: firefox] 05:35:07 INFO - mkdir: /builds/slave/test/build/application 05:35:07 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'] 05:35:07 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 05:35:41 INFO - Reading from file tmpfile_stdout 05:35:41 INFO - Output received: 05:35:41 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:35:41 INFO - Running post-action listener: _resource_record_post_action 05:35:41 INFO - ##### 05:35:41 INFO - ##### Running run-tests step. 05:35:41 INFO - ##### 05:35:41 INFO - Running pre-action listener: _resource_record_pre_action 05:35:41 INFO - Running main action method: run_tests 05:35:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:41 INFO - 2016-04-12 05:35:41.309 screenresolution[1646:7529] starting screenresolution argv=screenresolution get 05:35:41 INFO - 2016-04-12 05:35:41.311 screenresolution[1646:7529] Display 0: 1600x1200x32@60 05:35:41 INFO - 2016-04-12 05:35:41.317 screenresolution[1647:7531] starting screenresolution argv=screenresolution list 05:35:41 INFO - Available Modes on Display 0 05:35:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:41 INFO - Intel Iris: 05:35:41 INFO - Chipset Model: Intel Iris 05:35:41 INFO - Type: GPU 05:35:41 INFO - Bus: Built-In 05:35:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:41 INFO - Vendor: Intel (0x8086) 05:35:41 INFO - Device ID: 0x0a2e 05:35:41 INFO - Revision ID: 0x0009 05:35:41 INFO - Displays: 05:35:41 INFO - Display: 05:35:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:41 INFO - Display Serial Number: 1600x1200 60 05:35:41 INFO - Main Display: Yes 05:35:41 INFO - Mirror: Off 05:35:41 INFO - Online: Yes 05:35:41 INFO - Rotation: Supported 05:35:41 INFO - Return code: 0 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:35:41 INFO - Python 2.7.3 05:35:41 INFO - Return code: 0 05:35:41 INFO - grabbing minidump binary from tooltool 05:35:41 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')]} 05:35:41 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 0x10c06ce00>, '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 0x10bed5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c067b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:35:41 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 05:35:41 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 05:35:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:35:41 INFO - Return code: 0 05:35:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:35:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:35:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:35:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:35:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:35:42 INFO - Return code: 0 05:35:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:35:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oekLaku1nf/Render', 05:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:42 INFO - 'HOME': '/Users/cltbld', 05:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:42 INFO - 'LOGNAME': 'cltbld', 05:35:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:35:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:42 INFO - 'MOZ_NO_REMOTE': '1', 05:35:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:35:42 INFO - 'NO_EM_RESTART': '1', 05:35:42 INFO - 'PAGER': '/bin/cat', 05:35:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:42 INFO - 'PWD': '/builds/slave/test', 05:35:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:42 INFO - 'SHELL': '/bin/bash', 05:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OI09c984nG/Listeners', 05:35:42 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 05:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:42 INFO - 'USER': 'cltbld', 05:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:42 INFO - 'XPC_FLAGS': '0x0', 05:35:42 INFO - 'XPC_SERVICE_NAME': '0', 05:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:35:43 INFO - mozversion application_buildid: 20160412030235 05:35:43 INFO - mozversion application_changeset: 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 05:35:43 INFO - mozversion application_display_name: Nightly 05:35:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:35:43 INFO - mozversion application_name: Firefox 05:35:43 INFO - mozversion application_remotingname: firefox 05:35:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:35:43 INFO - mozversion application_vendor: Mozilla 05:35:43 INFO - mozversion application_version: 48.0a1 05:35:43 INFO - mozversion platform_buildid: 20160412030235 05:35:43 INFO - mozversion platform_changeset: 21bf1af375c1fa8565ae3bb2e89bd1a0809363d4 05:35:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:35:43 INFO - mozversion platform_version: 48.0a1 05:35:43 INFO - using testdate: 1460464543 05:35:43 INFO - actual date: 1460464543 05:35:43 INFO - starting webserver on 'localhost:49279' 05:35:43 INFO - SUITE-START | Running 2 tests 05:35:43 INFO - TEST-START | dromaeo_css 05:35:43 INFO - operating with platform_type : mac_ 05:35:43 INFO - Initialising browser for dromaeo_css test... 05:35:43 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpXnGfZs/profile http://localhost:49279/getInfo.html) 05:35:45 INFO - PROCESS | 1665 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:35:46 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 05:35:46 INFO - PROCESS | 1665 | colorDepth:24 05:35:46 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 05:35:46 INFO - PROCESS | 1665 | __metrics 05:35:46 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 05:35:46 INFO - TEST-INFO | 1665: exit 0 05:35:46 INFO - Browser initialized. 05:35:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:35:46 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpXnGfZs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:58 INFO - PROCESS | 1669 | RSS: Main: 247758848 05:35:58 INFO - PROCESS | 1669 | 05:36:48 INFO - PROCESS | 1669 | 1460464608321 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] 05:38:58 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 05:39:00 INFO - PROCESS | 1669 | RSS: Main: 260108288 05:39:00 INFO - PROCESS | 1669 | 05:42:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 05:42:02 INFO - PROCESS | 1669 | RSS: Main: 271687680 05:42:02 INFO - PROCESS | 1669 | 05:45:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 05:45:05 INFO - PROCESS | 1669 | RSS: Main: 273903616 05:45:05 INFO - PROCESS | 1669 | 05:48:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 05:48:07 INFO - PROCESS | 1669 | RSS: Main: 275390464 05:48:07 INFO - PROCESS | 1669 | 05:51:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 05:51:10 INFO - PROCESS | 1669 | RSS: Main: 278237184 05:51:10 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 05:54:13 INFO - PROCESS | 1669 | RSS: Main: 279183360 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | __start_tp_report 05:54:13 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 05:54:13 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 05:54:13 INFO - PROCESS | 1669 | |i|pagename|runs| 05:54:13 INFO - PROCESS | 1669 | |0;dojo.html;3422.691957723805;3442.414789485787;3489.9476507852387;3503.7897726136434;3520.7183425325975;5745.712714364281;5755.223044888939;5773.249477567915;5778.306603207616;5792.304923409186;4846.733429661367;5617.297837770278;5715.2855893013375;5767.36558978513;5803.245578074855;5247.344081989751;5272.868178295555;5299.629025968184;5333.546648534879;5347.1177255752755;525.5314833919706;4178.540360560336;5174.932183348406;5251.212318152288;5357.7589008494515;5200.895982080356;5218.399884013349;5247.9212811807665;5252.107141785887;5304.124819404794;5151.716655583941;5319.787208511655;5325.60057995648;5330.333708286465;5374.48942350476;5192.091384007821;5233.633645644806;5276.9736151319385;5307.203919412081;5320.228566857784;4776.283557466408;4842.539958703953;5616.719164041781;5661.60368774186;5696.857578560528;5007.2489126630935;6180.567360284782;6254.906176407358;6301.1493448384335;6309.87380252397;6234.719437625317;6271.655058971754;6293.96853015732;6315.052742088677;6328.11406403104;5364.731763411853;5457.481539253804;5905.527557795409;5906.527477801851;5907.438793314628;6206.937930620727;6236.469900058455;6275.874482510324;6322.873542529215;6330.208723909512;6204.5967012144065;6215.720292586844;6218.782342617987;6223.346548612421;6246.937530624636;6246.625202487865;6280.340564240689;6286.15136956505;6293.968530157412;6299.5275354348605;6029;6173.536984726164;6208.379162083846;6221.906671399933;6309.968450157719;6106.389361063858;6125.75438176821;6254.437100660963;6277.309495955441;6279.874402512016;4964.429090654548;4980.228064649985;5013.89972200554;5032.748362581856;5034.798608055637;4376.474823021194;4380.956190438119;4467.687261891701;4482.372467854503;4509.481409637933;5626.127950167731;5675.120356344773;5852.063669812809;5880.941190588125;5886.735096920649;6259.843503912348;6266.717997690115;6279.874402511924;6286.591371560834;6287.465565426898;5633.57748168889;5727.255456790591;5734.741936612862;5760.452756988163;5884.205632239678;5457.61796674229;5484.808031718871;5488.259085023471;5501.092319767274;5502;6372.745090196433;6383.521235907326;6389.361063893666;6389.393007664265;6393.2647745508;6118.4668989547035;6158.753649853956;6214.347493513116;6259.530535209969;6260.186175797117;6371.936280637135;6377.808665740035;6379.362063793584;6385.808425747235;6466.127072845105;6215.782447614311;6221.440070393686;6240.843978900564;6264.749410023548;6265.592736472115;4734.384530011076;6100.932336841124;6118.101457354478;6180.721867515883;6300.180976473029;5940.584159108821;6101.328853825987;6127.080937859357;6132.448079672851;6155.47678447337;5592.3009623797025;5755.079187330174;5978.222831031938;6137.539684523589;6171.537134715004;5011.699298042129;5707.686077265625;5810.4189581041555;6004.489618382487;6028.517718582415;6136.815895522963;6149.661768602769;6178.907316390168;6196.225471816023;6210.378962103934;5807;5958.986972214647;6059.363766804422;6073.908891366721;6083.543734219863 05:54:13 INFO - PROCESS | 1669 | |1;ext.html;495.2323897958164;522.2375332015257;544.743970333943;597.1997523318753;605.8851712848361;36891.893243202714;38325.61674383255;38400;38637.80681096594;38650.22699546011;39162;39333.01667458308;39872.40191397124;40019.79990100053;40041.59958400415;8035;9245.12171343723;9314.208292295163;9316.673916412927;9325.207357374631;8287.95856020722;8832;8926.598303076376;9302.534873256343;9375.390599611037;9465.195458386046;9475.194608458254;9522.714318570454;9602.951985240064;9624.663136790214;9400.482973436458;9464.242860571137;9546.093121153479;9558.378705384128;9563.187129094036;9443.952780236055;9454.196393306578;9532.52337383135;9582.952085239529;9627.518624068769;37867;38102.80948595239;38220.61779382226;38458.80770596157;38531.42202866959;2756.8621568921676;2785.3454438207004;3119.82840943748;3238.1257060593507;3303.884364047271;26862.328441788915;27219.727802722115;27389.726102739118;27581.58627620587;27672.58491122635;2666.5733482642686;2724.441489494649;2778.7221277872254;2843.132844482432;2896.811707239023;399523;402283.98858005815;403234.96765032265;403557;404275;58139.837203256546;58666.4133358661;58684.41315586789;58749.706251468466;58760;61734.69132654308;67259;68991;69507;69651.56219532293;16491.505254842374;16571.50285491437;16672.416465423652;16699.08155051484;16711.164441778106;12391.75216495665;12785.16896401731;12818.487260509663;12829.871701283055;12869.871301287054;19225.230990760494;19368.903155484415;19408.80591194098;19422.320218792276;19889.403317900487;8146;8295.8340833183;8296.626651800683;8315.750527484186;8366.958165209135;914.4696076275744;918.4902379179485;949.264320151874;1060.2101434431397;1081.2701426537055;23642.7635723644;29307;30082.24794380158;30115.698843011727;30119.247018824266;1056.5192837259028;1058.3861360410942;1090.569225156059;1106.6458733205297;1240.9689757755948;13011.609651710463;14943.028703134261;15119.622009449851;15164.469243576423;15257.923710381378;613044;618625;619869;621003.844788541;629127;50608.74695626572;53549;60048.399516005156;61054.252558634966;61650.075248871304;1372.293268966483;1424.3234463629901;1442.8773554248007;1466.288849907794;1472.8085348904788;24725.76371181398;27269.45461090807;29516;30059.699403006565;30152.944646937252;51013.979720406125;51505;51579.74210128925;51755.741221293654;51890.48109519007;522423;522484;524706;525853;526018;26594.468110637292;26833.597496037964;26872.462550748485;27231.72768272371;27382.178534643994;46438.76780616075;46675.53324466712;46690.533094669976;46992;47396.52603474059;37634.62365376421;38348;38592.80703596464;38994.220115598095;39168.6083139165;36956.93473717943;37109.072273193386;37195.25609487741;37553.87338379853;38091.61908380881;37055.258894822495;37270;37410.8129459351;37467.06332341713;38074.42888356732;31049;32331.676683232865;33076.83461582677;33427.83286083554;33534.832325838215;24554.895029724063;24563.263102106965;24775.62836557417;25196.622050669623;25338.74661253364 05:54:13 INFO - PROCESS | 1669 | |2;jquery.html;402.4627122791074;403.209708970418;405.81332587009973;408.9959100408995;409.4799604502282;14047.508337208199;18999.905000474995;19450.41648750538;19783;19804.60390792185;19451.221951121974;19564.021798910067;19918.90040549799;20174.495637609067;20479.18083276671;4793.784279707422;5287.206918962158;5899.174115623816;5973.133895585138;5984.132300816379;5879;5881.588288819784;5897.970510147465;5914.526837852962;5933.317668468117;5645.266115404992;5866.266716660418;6020.45815876571;6045.697715114226;6091.878162436748;4556.476005259405;5905.084711869667;5988.670623115727;6058.3032951210735;6082.787102451393;5742.971285143548;5756.625819321731;5861.238039054938;5951.940480595182;5976.760929562813;16124;23533.529329413486;24528.264152075466;24817.875910620332;25183;1830.3959693301179;1940.631280056799;2067.756484214629;2168.447046003275;2274.1585613323177;9620.807583848284;9981.201503879745;9985.550650220684;10056.94971525145;10187.898121018843;1468.3612628506635;1473.4842805018266;1737.7393390991326;1771.6301375292335;1799.8290162434548;67463;74569.6271518639;76724.61637691775;89295.55352223263;118862.40568797101;11515.366654834064;11617.825732614017;11687.415629218505;11697.76604467906;11866.644000679993;13128.934355328161;14199.148051116967;15028.398864045534;15049.924750376178;15103.773443398359;8301.750947471586;8419.579021048923;8567.314614830799;8586.570671466401;8680.088590697886;6867.484938629623;8214.8357032859;8368.916310836936;8390.664373425117;8462.02686691026;4556.476005259437;4602.286645569942;4664.743439110814;4713.905721885543;4735.934414756721;1825.516238196879;1928.5564320206151;1941.35935141403;1998.9500262493555;2037.521182522106;857.8412993596205;922.022655984645;1003.5684655598017;1008.2287050406445;1058.6823952814125;19201.51996200078;19758.70361944572;19787.50531236702;19896.104675289647;19954.20183192656;936.9812603747887;939.4128669581512;987.8419452887504;1008.8839783424853;1065.2330322168027;9458.95270523643;10428.374297542172;10430.530626121843;10499.843129833724;10541.631042913461;581665;607760;609723;614008;619050;83724;119865.40067299783;120970;123251.38374308251;124128;1034.9586016559404;1034.9689509314733;1037.5331101004579;1052.2318707343682;1055.440616473255;14984.325705343068;17450.12749362552;17479.82520174782;17491.47525574235;17786.37747678825;47179;47967.80080497876;48644.25379090212;48897.511024889296;49713.502864970884;65964;67707.66146169238;69577.34649188483;69735.6513217451;72156.9176462364;6379.744810207725;7938.166492518202;7995.440319177602;8153.959230203811;8425.957870210856;10119;11078.501467433824;11960.086386178169;12009.099317551043;12279.815802762787;5323.494268044529;10459.738506537398;10519.263651544625;10813.783724325627;10830;8750.906136732909;8834.249088827522;9456.763580910258;10256.743581410525;10817.459127043774;5483.122700367922;9155.404898681565;10725.981031801966;11021.889781102407;11353.048207465954;6490.643014634241;6749.73001079971;8060.717874874351;8083.757487275391;8260.545669988209;9695.70912872615;10701.785964280827;10813.080888124283;10940.179486538382;11084.61203857861 05:54:13 INFO - PROCESS | 1669 | |3;mootools.html;1398.8880889528837;1648.6620242850217;1830.5149135479091;1877.0896115384046;1967.8130577595123;6773.525853190278;8516.914830851689;8721.694740684077;8960.283177345822;8974.057723938982;8531.573421328923;8612.440191387555;8640.91359086409;8692.30461563075;8701.95649021754;2409.433783060984;2444.0712529238863;2451.3013791069548;2451.656768052474;2457.311952653251;2428.611422172453;2443.9755602443925;2460.9261722148362;2464.100603279799;2468.049800826677;2073.5749171419825;2090.550531635698;2424.781769640732;2438.207582535674;2451.7915977141965;2427.987860060697;2433.367324495644;2442.3894026493376;2452.2343912383144;2465.395977985387;2300.666403371502;2426.9271921842374;2427.6965379327585;2428.3929017745563;2436.2325867351906;8001.079875814297;8842;8847.955760221157;8857.557122143931;8869.822603547893;5263.552598029172;5468.562514998791;5516.062269414209;5531.032069387881;5537.640053396516;3563.8574457021687;3569.803660798655;3596.1549035976523;3617.2946275476293;3632.963670363289;1036.528379587286;1048.103871190129;1050.453764042701;1065.6749691344137;1068.6847380022912;11739.88260117405;11793.823092653616;11802.586909458214;11812.645620631309;11815.291082535075;4762.833300834454;4848.5636292733825;4866.732329721828;4956.306117143603;5004.524570165829;9937.850932236022;10006.299559030798;10019.098281154731;10053.346532475365;10063.446510441849;5469.206964990054;5471.261379713767;5500.58745594082;5506.201600767947;5525.198846167364;3732.925341493209;4840.419149702058;5011.398632164163;5012.824551140692;5018.623603229772;4020.0552870075508;4074.3684728867074;4080.4858331526057;4109.8972525687095;4116.773577453268;1328.0504439325928;1331.1414137881013;1331.2012792324722;1340.222670850904;1347.6967682271606;1109.1514991031868;1164.1559869094838;1176.2178151529138;1250.1561446023898;1370.7943808428615;8047.758567242992;8084.3936704747375;8124.187581241828;8128.146544612849;8157.877631835528;506.8150125204348;516.6460974232663;517.4825174825174;519.1175002495772;522.27925462861;6337.144485494491;6360.332165122688;6422.133012043408;6466.4503517201565;6516.120323756327;10535.578576856993;10811;10876.238663293652;10877.728056798485;11000.614978475714;10712.78574428507;10720.517576709066;10766.89233107659;10956.233063685624;11305.660830175108;8242.629081691339;8268.503889766633;8319.417640765208;8329.208725171098;8333.708320208763;6921.826954326182;8042.437029407885;8455.112213217524;8457.661693532189;8476.025257095513;7744.535327880345;9466.05339466048;9548.18840398574;9768.120869121813;9829;9661.323707340418;9892.159166470643;10007.399556026661;10051.145652619316;10108.241881858743;6717.261101278953;7385.889211661937;7476.775696729107;7508.43686723487;7774.961125194564;8510.531920744172;8520.403571749917;8556.401051926554;8575.056743758307;8588.785280368042;7467.290607392289;7594.164641889498;7642.04474440695;7678.232176782501;7739.5743234122665;7383.372413344711;7506.962465187639;7552.584607846621;7619.885701714589;7633.274838890296;7810.3751699865015;7908.6441110149035;7950.801229969297;7956.2441568050945;8053.557054362066;7062.576245425291;7101.680424381018;7145.964270178616;7181.676824543013;7182.928170718226;6123.4488895999575;7110.5022648414115;7246.818829529304;7250.057492525938;7301.123865136005 05:54:13 INFO - PROCESS | 1669 | |4;prototype.html;301.895845933153;325.8321964188443;332.5875913866806;334.86940093363586;340.02921658664513;6023.668698221596;6141.447269745722;6157.4275280870825;6159.8768024639485;6207.720652570634;6003.847979810602;6025.444987457399;6055.212822333102;6067.4842638375685;6085.452309292163;3968.960310396888;4107.342825147977;4534.1158474097565;4552.499225085238;4625.236835922069;4003.2794097062515;4510.300903359985;4523.434570678665;4535.682502224846;4593.379893714356;4168.291390463629;4507.797149128281;4520.615747661453;4548.749818759967;4570.177368073745;4397.31841564558;4550.794039579514;4554.86335409935;4592.862214133581;4607.285870690049;3446.879359222415;3619.457081437779;3876;3932.016995751062;3955.8417663293435;5038.294638750541;5768.836686242659;5806.390329015477;5829.271341082364;5837.88324233513;5143.254228136937;5161.27742116104;5188.962207558503;5343.759530821084;5354.491323324278;4843.4914333994775;4948.356713627241;5783.277090363705;6335.271443783978;6419.165508483914;3794.620537946211;3818.4654148419245;4279.7218180818145;4346.239408103569;4361.127774445124;6579.9671001645165;6663.400293973517;6726.544811143946;6762;6785.728570857111;3697.2605478904325;4377.387165796791;4418.6023257906945;4430.645548356124;4467.262901621196;4526.841560545365;4530.592246697813;4536.637069034469;4543.750093744809;4546.545345465427;4664.230401983635;5027.572656324181;5306.893862122736;5314.388845282765;5327.627066105335;5508.669479831223;6304.6445014321225;6465.935340646627;6498.935010649833;6534.509911756637;1405.6345350208815;1549.457689808558;1565.6320764620305;1566.4752307976728;1573;881.7310720230263;882.885224920769;884.1379654836483;965.358036905464;981.489625394805;5896.410358964155;5941.643501389931;5952.3154837193415;5973.313068997034;5976.850578735566;5500.697461639568;6616;6638.86722265552;6639.170103737033;6665.266820649725;4989.725565093955;5694.352126261226;5871.765129394862;6001.769637224358;6015.428534289235;3474.652534746556;3504.684578387957;3516.7889926604485;3535.098549869767;3536.929261414809;5808.854778630568;6794.150731158606;6839.829004274833;6903.549240019821;6929.7228110875;6449.419552240321;6747.831304217434;6750.696218670171;6780.525363224626;6836.111305530349;6720.8319792005595;6814.454843612598;6908.792736217922;6916.412104971134;6995.825104372431;6595.142631458071;6645.833854153685;6680.231773345933;6689.76585819494;6719.748884123873;5636.3799982002765;6268.780592679234;6517.674116294261;6521.64130972801;6575.605463672195;6018.849528761816;6120.938790612215;6864.725410983505;6866.189264957797;6888.655567221719;4099.713020088565;4315.4605674290715;4319.766628703825;4342.956570434255;4353.477582690098;6041.395860413923;6227.346128656607;6427.778722042797;6617.735290588515;6671.232808226922;6402.711877965409;6408.840883089158;6448.258450278278;6454.225492940877;6495.480361570969;5341.973290133525;6128.571000029955;6437.227532696106;6450.8064758057335;6477.676116194266;6008.969955150196;6128.509719222362;6239.251289845248;6285.277193122849;6321.715522801393;6409.935900640934;6448.677566121769;6470.288268290578;6495.902561461677;6508.674566271573;5272.604554658339;6089.847753806191;6330.683465826598;6358.55195749649;6410.775622853178 05:54:13 INFO - PROCESS | 1669 | |5;yui.html;561.1974875927422;676.2459857259156;747.4020783373302;766.0883548577193;784.7326567593335;14738.778918316233;14921.626959325995;15183.924080379611;15199.544013679593;15254.161021143833;12852.16460930039;12947.676308092303;12949.805752913713;12961.611151665442;13102.27937463439;717.7774889784183;803.6704950970103;904.9457032578066;926.2497377124517;939.8496240601505;879.2043200903192;918.6233644205877;926.9907300926972;927.4528028463205;928.5218112671979;934.8691183234353;975.4829940131741;981.950902454878;984.4782265399314;986.39336807863;927.5872236854602;953.3707752883098;961.9086186812242;976.3995142987083;977.0571398600349;695.4644923408947;705.1714235772946;716.6918225163178;732.1251104929611;732.8351120997786;14986.10083394989;15058;15128.092314461057;15140.318685659062;15166.014209076375;10538.473076346152;12825.23048617086;12892;13135.671608209776;13221.801672974912;9811.313208075437;10088.69733907984;10112.797744045152;10424.895751042544;10494.265401421904;3455.706264967481;3482.2165012872156;3489.145159435929;3499.7725147865563;3502.824858757052;71071.57856842886;74099.5180096395;74377.62811185964;75646.62176689136;81151;9261.583228754722;9398.812023759487;9537.427754334762;9575.99452057538;9618.422894626345;20824.687629685566;20969.370918872457;20999.160033598484;21102.155913763585;21193.894030530057;6087.847803804941;7099.964500177466;7402.888956665654;7727.150013498623;7821.608919554;3451.7238620910266;4057;4096.365063415175;4100.569440208795;4105.3020986432375;3501.7548771586253;3610.693091087287;3624.456331550236;3635.4546817976984;3639.1084184375;611.1382950040422;619.8842084248334;634.1597383466925;634.7461015593707;635.9618422894641;477.808876449423;573.9253896993364;607.817654703596;611.5963464113663;615.8141468944375;6719.328067193242;7830.138684744674;7988.840223195503;8005;8272.958635206785;510.2295533744073;551.9282493275848;582.5872259770041;583.8773857489974;584.2521572387351;3798.582155962842;3818.4654148419245;3891.9416208756893;3908.9413658795143;3988.980055099706;81410.18589814026;81617.59191204006;83268.16731832604;83318.16681833225;83819.5809020951;70024.64987675029;70208;70623.58752825018;70796;72016;63212;65547.36131596843;65605.67197163984;65755.67122164358;66011.00983485156;7454.105507339154;7506.3244308012545;7632.80917977055;7684.385249180164;7728.7681369559;40609.79695101506;41896.16207675768;42398.788006059774;42550.78724606357;44142;52315.73842130917;55132.72433637806;55867;56575.58561035842;56604.433955659915;8246.917530824616;9666.178374838217;9878.604855805686;10005.699829005142;10067.496625168566;10557.788844223227;10572.524236409226;10761.623343182951;10781.892181078403;10856.61523798176;10272.075513203847;10316.17470602335;10329.173666106844;10665.573377064831;10694.679159625224;10106.747331316776;10197.898021019695;10240.53917573696;10281.228907831794;10571.841422378824;10144.442055687008;10177.18582513412;10212.795744085226;10345.586176553155;10556.313839600401;8788.07725188846;8859.822803544022;8931.910680893368;9123.817523649357;9161.541922903962;8687.869681954902;8908.643654253758;8937.06160853127;8973.833401657743;8975.147361000694 05:54:13 INFO - PROCESS | 1669 | __end_tp_report 05:54:13 INFO - PROCESS | 1669 | __start_cc_report 05:54:13 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,389 05:54:13 INFO - PROCESS | 1669 | __end_cc_report 05:54:13 INFO - PROCESS | 1669 | __startTimestamp1460465653542__endTimestamp 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | ------- Summary: start ------- 05:54:13 INFO - PROCESS | 1669 | Number of tests: 6 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5704.95 Median:5907.44 stddev:768.44 (13.0%) stddev-sans-first:749.65 05:54:13 INFO - PROCESS | 1669 | Values: 3422.7 3442.4 3489.9 3503.8 3520.7 5745.7 5755.2 5773.2 5778.3 5792.3 4846.7 5617.3 5715.3 5767.4 5803.2 5247.3 5272.9 5299.6 5333.5 5347.1 525.5 4178.5 5174.9 5251.2 5357.8 5200.9 5218.4 5247.9 5252.1 5304.1 5151.7 5319.8 5325.6 5330.3 5374.5 5192.1 5233.6 5277.0 5307.2 5320.2 4776.3 4842.5 5616.7 5661.6 5696.9 5007.2 6180.6 6254.9 6301.1 6309.9 6234.7 6271.7 6294.0 6315.1 6328.1 5364.7 5457.5 5905.5 5906.5 5907.4 6206.9 6236.5 6275.9 6322.9 6330.2 6204.6 6215.7 6218.8 6223.3 6246.9 6246.6 6280.3 6286.2 6294.0 6299.5 6029.0 6173.5 6208.4 6221.9 6310.0 6106.4 6125.8 6254.4 6277.3 6279.9 4964.4 4980.2 5013.9 5032.7 5034.8 4376.5 4381.0 4467.7 4482.4 4509.5 5626.1 5675.1 5852.1 5880.9 5886.7 6259.8 6266.7 6279.9 6286.6 6287.5 5633.6 5727.3 5734.7 5760.5 5884.2 5457.6 5484.8 5488.3 5501.1 5502.0 6372.7 6383.5 6389.4 6389.4 6393.3 6118.5 6158.8 6214.3 6259.5 6260.2 6371.9 6377.8 6379.4 6385.8 6466.1 6215.8 6221.4 6240.8 6264.7 6265.6 4734.4 6100.9 6118.1 6180.7 6300.2 5940.6 6101.3 6127.1 6132.4 6155.5 5592.3 5755.1 5978.2 6137.5 6171.5 5011.7 5707.7 5810.4 6004.5 6028.5 6136.8 6149.7 6178.9 6196.2 6210.4 5807.0 5959.0 6059.4 6073.9 6083.5 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:65435.39 Median:38495.11 stddev:139727.35 (363.0%) stddev-sans-first:140034.25 05:54:13 INFO - PROCESS | 1669 | Values: 495.2 522.2 544.7 597.2 605.9 36891.9 38325.6 38400.0 38637.8 38650.2 39162.0 39333.0 39872.4 40019.8 40041.6 8035.0 9245.1 9314.2 9316.7 9325.2 8288.0 8832.0 8926.6 9302.5 9375.4 9465.2 9475.2 9522.7 9603.0 9624.7 9400.5 9464.2 9546.1 9558.4 9563.2 9444.0 9454.2 9532.5 9583.0 9627.5 37867.0 38102.8 38220.6 38458.8 38531.4 2756.9 2785.3 3119.8 3238.1 3303.9 26862.3 27219.7 27389.7 27581.6 27672.6 2666.6 2724.4 2778.7 2843.1 2896.8 399523.0 402284.0 403235.0 403557.0 404275.0 58139.8 58666.4 58684.4 58749.7 58760.0 61734.7 67259.0 68991.0 69507.0 69651.6 16491.5 16571.5 16672.4 16699.1 16711.2 12391.8 12785.2 12818.5 12829.9 12869.9 19225.2 19368.9 19408.8 19422.3 19889.4 8146.0 8295.8 8296.6 8315.8 8367.0 914.5 918.5 949.3 1060.2 1081.3 23642.8 29307.0 30082.2 30115.7 30119.2 1056.5 1058.4 1090.6 1106.6 1241.0 13011.6 14943.0 15119.6 15164.5 15257.9 613044.0 618625.0 619869.0 621003.8 629127.0 50608.7 53549.0 60048.4 61054.3 61650.1 1372.3 1424.3 1442.9 1466.3 1472.8 24725.8 27269.5 29516.0 30059.7 30152.9 51014.0 51505.0 51579.7 51755.7 51890.5 522423.0 522484.0 524706.0 525853.0 526018.0 26594.5 26833.6 26872.5 27231.7 27382.2 46438.8 46675.5 46690.5 46992.0 47396.5 37634.6 38348.0 38592.8 38994.2 39168.6 36956.9 37109.1 37195.3 37553.9 38091.6 37055.3 37270.0 37410.8 37467.1 38074.4 31049.0 32331.7 33076.8 33427.8 33534.8 24554.9 24563.3 24775.6 25196.6 25338.7 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33154.38 Median:404.51 stddev:100269.09 (24787.7%) stddev-sans-first:100520.21 05:54:13 INFO - PROCESS | 1669 | Values: 402.5 403.2 405.8 409.0 409.5 14047.5 18999.9 19450.4 19783.0 19804.6 19451.2 19564.0 19918.9 20174.5 20479.2 4793.8 5287.2 5899.2 5973.1 5984.1 5879.0 5881.6 5898.0 5914.5 5933.3 5645.3 5866.3 6020.5 6045.7 6091.9 4556.5 5905.1 5988.7 6058.3 6082.8 5743.0 5756.6 5861.2 5951.9 5976.8 16124.0 23533.5 24528.3 24817.9 25183.0 1830.4 1940.6 2067.8 2168.4 2274.2 9620.8 9981.2 9985.6 10056.9 10187.9 1468.4 1473.5 1737.7 1771.6 1799.8 67463.0 74569.6 76724.6 89295.6 118862.4 11515.4 11617.8 11687.4 11697.8 11866.6 13128.9 14199.1 15028.4 15049.9 15103.8 8301.8 8419.6 8567.3 8586.6 8680.1 6867.5 8214.8 8368.9 8390.7 8462.0 4556.5 4602.3 4664.7 4713.9 4735.9 1825.5 1928.6 1941.4 1999.0 2037.5 857.8 922.0 1003.6 1008.2 1058.7 19201.5 19758.7 19787.5 19896.1 19954.2 937.0 939.4 987.8 1008.9 1065.2 9459.0 10428.4 10430.5 10499.8 10541.6 581665.0 607760.0 609723.0 614008.0 619050.0 83724.0 119865.4 120970.0 123251.4 124128.0 1035.0 1035.0 1037.5 1052.2 1055.4 14984.3 17450.1 17479.8 17491.5 17786.4 47179.0 47967.8 48644.3 48897.5 49713.5 65964.0 67707.7 69577.3 69735.7 72156.9 6379.7 7938.2 7995.4 8154.0 8426.0 10119.0 11078.5 11960.1 12009.1 12279.8 5323.5 10459.7 10519.3 10813.8 10830.0 8750.9 8834.2 9456.8 10256.7 10817.5 5483.1 9155.4 10726.0 11021.9 11353.0 6490.6 6749.7 8060.7 8083.8 8260.5 9695.7 10701.8 10813.1 10940.2 11084.6 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:6073.81 Median:520.70 stddev:3230.83 (620.5%) stddev-sans-first:3220.78 05:54:13 INFO - PROCESS | 1669 | Values: 1398.9 1648.7 1830.5 1877.1 1967.8 6773.5 8516.9 8721.7 8960.3 8974.1 8531.6 8612.4 8640.9 8692.3 8702.0 2409.4 2444.1 2451.3 2451.7 2457.3 2428.6 2444.0 2460.9 2464.1 2468.0 2073.6 2090.6 2424.8 2438.2 2451.8 2428.0 2433.4 2442.4 2452.2 2465.4 2300.7 2426.9 2427.7 2428.4 2436.2 8001.1 8842.0 8848.0 8857.6 8869.8 5263.6 5468.6 5516.1 5531.0 5537.6 3563.9 3569.8 3596.2 3617.3 3633.0 1036.5 1048.1 1050.5 1065.7 1068.7 11739.9 11793.8 11802.6 11812.6 11815.3 4762.8 4848.6 4866.7 4956.3 5004.5 9937.9 10006.3 10019.1 10053.3 10063.4 5469.2 5471.3 5500.6 5506.2 5525.2 3732.9 4840.4 5011.4 5012.8 5018.6 4020.1 4074.4 4080.5 4109.9 4116.8 1328.1 1331.1 1331.2 1340.2 1347.7 1109.2 1164.2 1176.2 1250.2 1370.8 8047.8 8084.4 8124.2 8128.1 8157.9 506.8 516.6 517.5 519.1 522.3 6337.1 6360.3 6422.1 6466.5 6516.1 10535.6 10811.0 10876.2 10877.7 11000.6 10712.8 10720.5 10766.9 10956.2 11305.7 8242.6 8268.5 8319.4 8329.2 8333.7 6921.8 8042.4 8455.1 8457.7 8476.0 7744.5 9466.1 9548.2 9768.1 9829.0 9661.3 9892.2 10007.4 10051.1 10108.2 6717.3 7385.9 7476.8 7508.4 7775.0 8510.5 8520.4 8556.4 8575.1 8588.8 7467.3 7594.2 7642.0 7678.2 7739.6 7383.4 7507.0 7552.6 7619.9 7633.3 7810.4 7908.6 7950.8 7956.2 8053.6 7062.6 7101.7 7146.0 7181.7 7182.9 6123.4 7110.5 7246.8 7250.1 7301.1 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5208.68 Median:5975.08 stddev:1635.92 (27.4%) stddev-sans-first:1598.52 05:54:13 INFO - PROCESS | 1669 | Values: 301.9 325.8 332.6 334.9 340.0 6023.7 6141.4 6157.4 6159.9 6207.7 6003.8 6025.4 6055.2 6067.5 6085.5 3969.0 4107.3 4534.1 4552.5 4625.2 4003.3 4510.3 4523.4 4535.7 4593.4 4168.3 4507.8 4520.6 4548.7 4570.2 4397.3 4550.8 4554.9 4592.9 4607.3 3446.9 3619.5 3876.0 3932.0 3955.8 5038.3 5768.8 5806.4 5829.3 5837.9 5143.3 5161.3 5189.0 5343.8 5354.5 4843.5 4948.4 5783.3 6335.3 6419.2 3794.6 3818.5 4279.7 4346.2 4361.1 6580.0 6663.4 6726.5 6762.0 6785.7 3697.3 4377.4 4418.6 4430.6 4467.3 4526.8 4530.6 4536.6 4543.8 4546.5 4664.2 5027.6 5306.9 5314.4 5327.6 5508.7 6304.6 6465.9 6498.9 6534.5 1405.6 1549.5 1565.6 1566.5 1573.0 881.7 882.9 884.1 965.4 981.5 5896.4 5941.6 5952.3 5973.3 5976.9 5500.7 6616.0 6638.9 6639.2 6665.3 4989.7 5694.4 5871.8 6001.8 6015.4 3474.7 3504.7 3516.8 3535.1 3536.9 5808.9 6794.2 6839.8 6903.5 6929.7 6449.4 6747.8 6750.7 6780.5 6836.1 6720.8 6814.5 6908.8 6916.4 6995.8 6595.1 6645.8 6680.2 6689.8 6719.7 5636.4 6268.8 6517.7 6521.6 6575.6 6018.8 6120.9 6864.7 6866.2 6888.7 4099.7 4315.5 4319.8 4343.0 4353.5 6041.4 6227.3 6427.8 6617.7 6671.2 6402.7 6408.8 6448.3 6454.2 6495.5 5342.0 6128.6 6437.2 6450.8 6477.7 6009.0 6128.5 6239.3 6285.3 6321.7 6409.9 6448.7 6470.3 6495.9 6508.7 5272.6 6089.8 6330.7 6358.6 6410.8 05:54:13 INFO - PROCESS | 1669 | 05:54:13 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:16706.96 Median:3349.49 stddev:22985.20 (686.2%) stddev-sans-first:23017.70 05:54:13 INFO - PROCESS | 1669 | Values: 561.2 676.2 747.4 766.1 784.7 14738.8 14921.6 15183.9 15199.5 15254.2 12852.2 12947.7 12949.8 12961.6 13102.3 717.8 803.7 904.9 926.2 939.8 879.2 918.6 927.0 927.5 928.5 934.9 975.5 982.0 984.5 986.4 927.6 953.4 961.9 976.4 977.1 695.5 705.2 716.7 732.1 732.8 14986.1 15058.0 15128.1 15140.3 15166.0 10538.5 12825.2 12892.0 13135.7 13221.8 9811.3 10088.7 10112.8 10424.9 10494.3 3455.7 3482.2 3489.1 3499.8 3502.8 71071.6 74099.5 74377.6 75646.6 81151.0 9261.6 9398.8 9537.4 9576.0 9618.4 20824.7 20969.4 20999.2 21102.2 21193.9 6087.8 7100.0 7402.9 7727.2 7821.6 3451.7 4057.0 4096.4 4100.6 4105.3 3501.8 3610.7 3624.5 3635.5 3639.1 611.1 619.9 634.2 634.7 636.0 477.8 573.9 607.8 611.6 615.8 6719.3 7830.1 7988.8 8005.0 8273.0 510.2 551.9 582.6 583.9 584.3 3798.6 3818.5 3891.9 3908.9 3989.0 81410.2 81617.6 83268.2 83318.2 83819.6 70024.6 70208.0 70623.6 70796.0 72016.0 63212.0 65547.4 65605.7 65755.7 66011.0 7454.1 7506.3 7632.8 7684.4 7728.8 40609.8 41896.2 42398.8 42550.8 44142.0 52315.7 55132.7 55867.0 56575.6 56604.4 8246.9 9666.2 9878.6 10005.7 10067.5 10557.8 10572.5 10761.6 10781.9 10856.6 10272.1 10316.2 10329.2 10665.6 10694.7 10106.7 10197.9 10240.5 10281.2 10571.8 10144.4 10177.2 10212.8 10345.6 10556.3 8788.1 8859.8 8931.9 9123.8 9161.5 8687.9 8908.6 8937.1 8973.8 8975.1 05:54:13 INFO - PROCESS | 1669 | -------- Summary: end -------- 05:54:13 INFO - PROCESS | 1669 | 05:54:14 INFO - TEST-INFO | 1669: exit 0 05:54:14 INFO - TEST-OK | dromaeo_css | took 1111061ms 05:54:14 INFO - TEST-START | kraken 05:54:14 INFO - operating with platform_type : mac_ 05:54:14 INFO - Initialising browser for kraken test... 05:54:14 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpewWlzd/profile http://localhost:49279/getInfo.html) 05:54:16 INFO - PROCESS | 1680 | JavaScript error: jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 05:54:17 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 05:54:17 INFO - PROCESS | 1680 | colorDepth:24 05:54:17 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 05:54:17 INFO - PROCESS | 1680 | __metrics 05:54:17 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2929: TypeError: this.tabs is undefined 05:54:17 INFO - TEST-INFO | 1680: exit 0 05:54:17 INFO - Browser initialized. 05:54:17 INFO - Running cycle 1/1 for kraken test... 05:54:17 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpewWlzd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:29 INFO - PROCESS | 1684 | RSS: Main: 247910400 05:54:29 INFO - PROCESS | 1684 | 05:54:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 05:54:34 INFO - PROCESS | 1684 | RSS: Main: 260124672 05:54:34 INFO - PROCESS | 1684 | 05:54:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 05:54:37 INFO - PROCESS | 1684 | RSS: Main: 269021184 05:54:37 INFO - PROCESS | 1684 | 05:54:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 05:54:41 INFO - PROCESS | 1684 | RSS: Main: 272035840 05:54:41 INFO - PROCESS | 1684 | 05:54:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 05:54:43 INFO - PROCESS | 1684 | RSS: Main: 274022400 05:54:43 INFO - PROCESS | 1684 | 05:54:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:54:46 INFO - PROCESS | 1684 | RSS: Main: 274653184 05:54:46 INFO - PROCESS | 1684 | 05:54:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 05:54:50 INFO - PROCESS | 1684 | RSS: Main: 274722816 05:54:50 INFO - PROCESS | 1684 | 05:54:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 05:54:53 INFO - PROCESS | 1684 | RSS: Main: 274989056 05:54:53 INFO - PROCESS | 1684 | 05:54:56 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 05:54:57 INFO - PROCESS | 1684 | RSS: Main: 275611648 05:54:57 INFO - PROCESS | 1684 | 05:54:59 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:54:59 INFO - PROCESS | 1684 | RSS: Main: 275443712 05:54:59 INFO - PROCESS | 1684 | 05:55:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:02 INFO - PROCESS | 1684 | RSS: Main: 275136512 05:55:02 INFO - PROCESS | 1684 | 05:55:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:05 INFO - PROCESS | 1684 | RSS: Main: 275087360 05:55:05 INFO - PROCESS | 1684 | 05:55:08 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:08 INFO - PROCESS | 1684 | RSS: Main: 275202048 05:55:08 INFO - PROCESS | 1684 | 05:55:11 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:55:12 INFO - PROCESS | 1684 | RSS: Main: 275087360 05:55:12 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 05:55:14 INFO - PROCESS | 1684 | RSS: Main: 276549632 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | __start_tp_report 05:55:14 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 05:55:14 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 05:55:14 INFO - PROCESS | 1684 | |i|pagename|runs| 05:55:14 INFO - PROCESS | 1684 | |0;ai-astar;174;157;99;173;171;185;114;116;117;117 05:55:14 INFO - PROCESS | 1684 | |1;audio-beat-detection;153;144;184;162;131;171;133;156;208;151 05:55:14 INFO - PROCESS | 1684 | |2;audio-dft;202;232;199;200;199;197;199;201;203;195 05:55:14 INFO - PROCESS | 1684 | |3;audio-fft;70;78;74;132;55;56;66;59;79;80 05:55:14 INFO - PROCESS | 1684 | |4;audio-oscillator;81;86;123;78;82;90;123;79;83;125 05:55:14 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;134;123;88;88;79;115;134;109;118;131 05:55:14 INFO - PROCESS | 1684 | |6;imaging-darkroom;93;110;149;95;93;94;94;95;94;103 05:55:14 INFO - PROCESS | 1684 | |7;imaging-desaturate;146;148;93;93;97;150;93;115;144;95 05:55:14 INFO - PROCESS | 1684 | |8;json-parse-financial;55;56;57;58;56;57;57;75;67;79 05:55:14 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;65;67;73;65;70;73;71;68;66;70 05:55:14 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;95;88;92;113;113;87;91;90;89;88 05:55:14 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;146;145;164;153;168;165;166;167;211;161 05:55:14 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;175;172;177;175;175;174;190;174;170;173 05:55:14 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;69;73;71;67;75;72;73;69;69;70 05:55:14 INFO - PROCESS | 1684 | __end_tp_report 05:55:14 INFO - PROCESS | 1684 | __start_cc_report 05:55:14 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1003 05:55:14 INFO - PROCESS | 1684 | __end_cc_report 05:55:14 INFO - PROCESS | 1684 | __startTimestamp1460465714334__endTimestamp 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | ------- Summary: start ------- 05:55:14 INFO - PROCESS | 1684 | Number of tests: 14 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:142.30 Median:172.00 stddev:32.42 (18.8%) stddev-sans-first:32.29 05:55:14 INFO - PROCESS | 1684 | Values: 174.0 157.0 99.0 173.0 171.0 185.0 114.0 116.0 117.0 117.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:159.30 Median:159.00 stddev:23.50 (14.8%) stddev-sans-first:24.82 05:55:14 INFO - PROCESS | 1684 | Values: 153.0 144.0 184.0 162.0 131.0 171.0 133.0 156.0 208.0 151.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:202.70 Median:200.50 stddev:10.55 (5.3%) stddev-sans-first:11.19 05:55:14 INFO - PROCESS | 1684 | Values: 202.0 232.0 199.0 200.0 199.0 197.0 199.0 201.0 203.0 195.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:74.90 Median:72.00 stddev:22.17 (30.8%) stddev-sans-first:23.44 05:55:14 INFO - PROCESS | 1684 | Values: 70.0 78.0 74.0 132.0 55.0 56.0 66.0 59.0 79.0 80.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:81.50 stddev:20.08 (24.6%) stddev-sans-first:20.65 05:55:14 INFO - PROCESS | 1684 | Values: 81.0 86.0 123.0 78.0 82.0 90.0 123.0 79.0 83.0 125.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:111.90 Median:134.00 stddev:20.40 (15.2%) stddev-sans-first:20.01 05:55:14 INFO - PROCESS | 1684 | Values: 134.0 123.0 88.0 88.0 79.0 115.0 134.0 109.0 118.0 131.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:94.00 stddev:17.40 (18.5%) stddev-sans-first:18.15 05:55:14 INFO - PROCESS | 1684 | Values: 93.0 110.0 149.0 95.0 93.0 94.0 94.0 95.0 94.0 103.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:117.40 Median:93.00 stddev:26.32 (28.3%) stddev-sans-first:25.80 05:55:14 INFO - PROCESS | 1684 | Values: 146.0 148.0 93.0 93.0 97.0 150.0 93.0 115.0 144.0 95.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:57.50 stddev:8.78 (15.3%) stddev-sans-first:8.97 05:55:14 INFO - PROCESS | 1684 | Values: 55.0 56.0 57.0 58.0 56.0 57.0 57.0 75.0 67.0 79.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:70.00 stddev:3.05 (4.4%) stddev-sans-first:2.91 05:55:14 INFO - PROCESS | 1684 | Values: 65.0 67.0 73.0 65.0 70.0 73.0 71.0 68.0 66.0 70.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:89.50 stddev:9.97 (11.1%) stddev-sans-first:10.57 05:55:14 INFO - PROCESS | 1684 | Values: 95.0 88.0 92.0 113.0 113.0 87.0 91.0 90.0 89.0 88.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:164.60 Median:165.50 stddev:18.41 (11.1%) stddev-sans-first:18.26 05:55:14 INFO - PROCESS | 1684 | Values: 146.0 145.0 164.0 153.0 168.0 165.0 166.0 167.0 211.0 161.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.50 Median:175.00 stddev:5.44 (3.1%) stddev-sans-first:5.77 05:55:14 INFO - PROCESS | 1684 | Values: 175.0 172.0 177.0 175.0 175.0 174.0 190.0 174.0 170.0 173.0 05:55:14 INFO - PROCESS | 1684 | 05:55:14 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:2.44 (3.4%) stddev-sans-first:2.50 05:55:14 INFO - PROCESS | 1684 | Values: 69.0 73.0 71.0 67.0 75.0 72.0 73.0 69.0 69.0 70.0 05:55:14 INFO - PROCESS | 1684 | -------- Summary: end -------- 05:55:14 INFO - PROCESS | 1684 | 05:55:15 INFO - TEST-INFO | 1684: exit 0 05:55:15 INFO - TEST-OK | kraken | took 60976ms 05:55:15 INFO - SUITE-END | took 1172s 05:55:15 INFO - Completed test suite (00:19:32) 05:55:15 INFO - javascript benchmark 05:55:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3422.691957723805, 3442.414789485787, 3489.9476507852387, 3503.7897726136434, 3520.7183425325975, 5745.712714364281, 5755.223044888939, 5773.249477567915, 5778.306603207616, 5792.304923409186, 4846.733429661367, 5617.297837770278, 5715.2855893013375, 5767.36558978513, 5803.245578074855, 5247.344081989751, 5272.868178295555, 5299.629025968184, 5333.546648534879, 5347.1177255752755, 525.5314833919706, 4178.540360560336, 5174.932183348406, 5251.212318152288, 5357.7589008494515, 5200.895982080356, 5218.399884013349, 5247.9212811807665, 5252.107141785887, 5304.124819404794, 5151.716655583941, 5319.787208511655, 5325.60057995648, 5330.333708286465, 5374.48942350476, 5192.091384007821, 5233.633645644806, 5276.9736151319385, 5307.203919412081, 5320.228566857784, 4776.283557466408, 4842.539958703953, 5616.719164041781, 5661.60368774186, 5696.857578560528, 5007.2489126630935, 6180.567360284782, 6254.906176407358, 6301.1493448384335, 6309.87380252397, 6234.719437625317, 6271.655058971754, 6293.96853015732, 6315.052742088677, 6328.11406403104, 5364.731763411853, 5457.481539253804, 5905.527557795409, 5906.527477801851, 5907.438793314628, 6206.937930620727, 6236.469900058455, 6275.874482510324, 6322.873542529215, 6330.208723909512, 6204.5967012144065, 6215.720292586844, 6218.782342617987, 6223.346548612421, 6246.937530624636, 6246.625202487865, 6280.340564240689, 6286.15136956505, 6293.968530157412, 6299.5275354348605, 6029.0, 6173.536984726164, 6208.379162083846, 6221.906671399933, 6309.968450157719, 6106.389361063858, 6125.75438176821, 6254.437100660963, 6277.309495955441, 6279.874402512016, 4964.429090654548, 4980.228064649985, 5013.89972200554, 5032.748362581856, 5034.798608055637, 4376.474823021194, 4380.956190438119, 4467.687261891701, 4482.372467854503, 4509.481409637933, 5626.127950167731, 5675.120356344773, 5852.063669812809, 5880.941190588125, 5886.735096920649, 6259.843503912348, 6266.717997690115, 6279.874402511924, 6286.591371560834, 6287.465565426898, 5633.57748168889, 5727.255456790591, 5734.741936612862, 5760.452756988163, 5884.205632239678, 5457.61796674229, 5484.808031718871, 5488.259085023471, 5501.092319767274, 5502.0, 6372.745090196433, 6383.521235907326, 6389.361063893666, 6389.393007664265, 6393.2647745508, 6118.4668989547035, 6158.753649853956, 6214.347493513116, 6259.530535209969, 6260.186175797117, 6371.936280637135, 6377.808665740035, 6379.362063793584, 6385.808425747235, 6466.127072845105, 6215.782447614311, 6221.440070393686, 6240.843978900564, 6264.749410023548, 6265.592736472115, 4734.384530011076, 6100.932336841124, 6118.101457354478, 6180.721867515883, 6300.180976473029, 5940.584159108821, 6101.328853825987, 6127.080937859357, 6132.448079672851, 6155.47678447337, 5592.3009623797025, 5755.079187330174, 5978.222831031938, 6137.539684523589, 6171.537134715004, 5011.699298042129, 5707.686077265625, 5810.4189581041555, 6004.489618382487, 6028.517718582415, 6136.815895522963, 6149.661768602769, 6178.907316390168, 6196.225471816023, 6210.378962103934, 5807.0, 5958.986972214647, 6059.363766804422, 6073.908891366721, 6083.543734219863], "value": 5658.999064420376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.2323897958164, 522.2375332015257, 544.743970333943, 597.1997523318753, 605.8851712848361, 36891.893243202714, 38325.61674383255, 38400.0, 38637.80681096594, 38650.22699546011, 39162.0, 39333.01667458308, 39872.40191397124, 40019.79990100053, 40041.59958400415, 8035.0, 9245.12171343723, 9314.208292295163, 9316.673916412927, 9325.207357374631, 8287.95856020722, 8832.0, 8926.598303076376, 9302.534873256343, 9375.390599611037, 9465.195458386046, 9475.194608458254, 9522.714318570454, 9602.951985240064, 9624.663136790214, 9400.482973436458, 9464.242860571137, 9546.093121153479, 9558.378705384128, 9563.187129094036, 9443.952780236055, 9454.196393306578, 9532.52337383135, 9582.952085239529, 9627.518624068769, 37867.0, 38102.80948595239, 38220.61779382226, 38458.80770596157, 38531.42202866959, 2756.8621568921676, 2785.3454438207004, 3119.82840943748, 3238.1257060593507, 3303.884364047271, 26862.328441788915, 27219.727802722115, 27389.726102739118, 27581.58627620587, 27672.58491122635, 2666.5733482642686, 2724.441489494649, 2778.7221277872254, 2843.132844482432, 2896.811707239023, 399523.0, 402283.98858005815, 403234.96765032265, 403557.0, 404275.0, 58139.837203256546, 58666.4133358661, 58684.41315586789, 58749.706251468466, 58760.0, 61734.69132654308, 67259.0, 68991.0, 69507.0, 69651.56219532293, 16491.505254842374, 16571.50285491437, 16672.416465423652, 16699.08155051484, 16711.164441778106, 12391.75216495665, 12785.16896401731, 12818.487260509663, 12829.871701283055, 12869.871301287054, 19225.230990760494, 19368.903155484415, 19408.80591194098, 19422.320218792276, 19889.403317900487, 8146.0, 8295.8340833183, 8296.626651800683, 8315.750527484186, 8366.958165209135, 914.4696076275744, 918.4902379179485, 949.264320151874, 1060.2101434431397, 1081.2701426537055, 23642.7635723644, 29307.0, 30082.24794380158, 30115.698843011727, 30119.247018824266, 1056.5192837259028, 1058.3861360410942, 1090.569225156059, 1106.6458733205297, 1240.9689757755948, 13011.609651710463, 14943.028703134261, 15119.622009449851, 15164.469243576423, 15257.923710381378, 613044.0, 618625.0, 619869.0, 621003.844788541, 629127.0, 50608.74695626572, 53549.0, 60048.399516005156, 61054.252558634966, 61650.075248871304, 1372.293268966483, 1424.3234463629901, 1442.8773554248007, 1466.288849907794, 1472.8085348904788, 24725.76371181398, 27269.45461090807, 29516.0, 30059.699403006565, 30152.944646937252, 51013.979720406125, 51505.0, 51579.74210128925, 51755.741221293654, 51890.48109519007, 522423.0, 522484.0, 524706.0, 525853.0, 526018.0, 26594.468110637292, 26833.597496037964, 26872.462550748485, 27231.72768272371, 27382.178534643994, 46438.76780616075, 46675.53324466712, 46690.533094669976, 46992.0, 47396.52603474059, 37634.62365376421, 38348.0, 38592.80703596464, 38994.220115598095, 39168.6083139165, 36956.93473717943, 37109.072273193386, 37195.25609487741, 37553.87338379853, 38091.61908380881, 37055.258894822495, 37270.0, 37410.8129459351, 37467.06332341713, 38074.42888356732, 31049.0, 32331.676683232865, 33076.83461582677, 33427.83286083554, 33534.832325838215, 24554.895029724063, 24563.263102106965, 24775.62836557417, 25196.622050669623, 25338.74661253364], "value": 19513.239985536657, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.4627122791074, 403.209708970418, 405.81332587009973, 408.9959100408995, 409.4799604502282, 14047.508337208199, 18999.905000474995, 19450.41648750538, 19783.0, 19804.60390792185, 19451.221951121974, 19564.021798910067, 19918.90040549799, 20174.495637609067, 20479.18083276671, 4793.784279707422, 5287.206918962158, 5899.174115623816, 5973.133895585138, 5984.132300816379, 5879.0, 5881.588288819784, 5897.970510147465, 5914.526837852962, 5933.317668468117, 5645.266115404992, 5866.266716660418, 6020.45815876571, 6045.697715114226, 6091.878162436748, 4556.476005259405, 5905.084711869667, 5988.670623115727, 6058.3032951210735, 6082.787102451393, 5742.971285143548, 5756.625819321731, 5861.238039054938, 5951.940480595182, 5976.760929562813, 16124.0, 23533.529329413486, 24528.264152075466, 24817.875910620332, 25183.0, 1830.3959693301179, 1940.631280056799, 2067.756484214629, 2168.447046003275, 2274.1585613323177, 9620.807583848284, 9981.201503879745, 9985.550650220684, 10056.94971525145, 10187.898121018843, 1468.3612628506635, 1473.4842805018266, 1737.7393390991326, 1771.6301375292335, 1799.8290162434548, 67463.0, 74569.6271518639, 76724.61637691775, 89295.55352223263, 118862.40568797101, 11515.366654834064, 11617.825732614017, 11687.415629218505, 11697.76604467906, 11866.644000679993, 13128.934355328161, 14199.148051116967, 15028.398864045534, 15049.924750376178, 15103.773443398359, 8301.750947471586, 8419.579021048923, 8567.314614830799, 8586.570671466401, 8680.088590697886, 6867.484938629623, 8214.8357032859, 8368.916310836936, 8390.664373425117, 8462.02686691026, 4556.476005259437, 4602.286645569942, 4664.743439110814, 4713.905721885543, 4735.934414756721, 1825.516238196879, 1928.5564320206151, 1941.35935141403, 1998.9500262493555, 2037.521182522106, 857.8412993596205, 922.022655984645, 1003.5684655598017, 1008.2287050406445, 1058.6823952814125, 19201.51996200078, 19758.70361944572, 19787.50531236702, 19896.104675289647, 19954.20183192656, 936.9812603747887, 939.4128669581512, 987.8419452887504, 1008.8839783424853, 1065.2330322168027, 9458.95270523643, 10428.374297542172, 10430.530626121843, 10499.843129833724, 10541.631042913461, 581665.0, 607760.0, 609723.0, 614008.0, 619050.0, 83724.0, 119865.40067299783, 120970.0, 123251.38374308251, 124128.0, 1034.9586016559404, 1034.9689509314733, 1037.5331101004579, 1052.2318707343682, 1055.440616473255, 14984.325705343068, 17450.12749362552, 17479.82520174782, 17491.47525574235, 17786.37747678825, 47179.0, 47967.80080497876, 48644.25379090212, 48897.511024889296, 49713.502864970884, 65964.0, 67707.66146169238, 69577.34649188483, 69735.6513217451, 72156.9176462364, 6379.744810207725, 7938.166492518202, 7995.440319177602, 8153.959230203811, 8425.957870210856, 10119.0, 11078.501467433824, 11960.086386178169, 12009.099317551043, 12279.815802762787, 5323.494268044529, 10459.738506537398, 10519.263651544625, 10813.783724325627, 10830.0, 8750.906136732909, 8834.249088827522, 9456.763580910258, 10256.743581410525, 10817.459127043774, 5483.122700367922, 9155.404898681565, 10725.981031801966, 11021.889781102407, 11353.048207465954, 6490.643014634241, 6749.73001079971, 8060.717874874351, 8083.757487275391, 8260.545669988209, 9695.70912872615, 10701.785964280827, 10813.080888124283, 10940.179486538382, 11084.61203857861], "value": 9106.747074368877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.8880889528837, 1648.6620242850217, 1830.5149135479091, 1877.0896115384046, 1967.8130577595123, 6773.525853190278, 8516.914830851689, 8721.694740684077, 8960.283177345822, 8974.057723938982, 8531.573421328923, 8612.440191387555, 8640.91359086409, 8692.30461563075, 8701.95649021754, 2409.433783060984, 2444.0712529238863, 2451.3013791069548, 2451.656768052474, 2457.311952653251, 2428.611422172453, 2443.9755602443925, 2460.9261722148362, 2464.100603279799, 2468.049800826677, 2073.5749171419825, 2090.550531635698, 2424.781769640732, 2438.207582535674, 2451.7915977141965, 2427.987860060697, 2433.367324495644, 2442.3894026493376, 2452.2343912383144, 2465.395977985387, 2300.666403371502, 2426.9271921842374, 2427.6965379327585, 2428.3929017745563, 2436.2325867351906, 8001.079875814297, 8842.0, 8847.955760221157, 8857.557122143931, 8869.822603547893, 5263.552598029172, 5468.562514998791, 5516.062269414209, 5531.032069387881, 5537.640053396516, 3563.8574457021687, 3569.803660798655, 3596.1549035976523, 3617.2946275476293, 3632.963670363289, 1036.528379587286, 1048.103871190129, 1050.453764042701, 1065.6749691344137, 1068.6847380022912, 11739.88260117405, 11793.823092653616, 11802.586909458214, 11812.645620631309, 11815.291082535075, 4762.833300834454, 4848.5636292733825, 4866.732329721828, 4956.306117143603, 5004.524570165829, 9937.850932236022, 10006.299559030798, 10019.098281154731, 10053.346532475365, 10063.446510441849, 5469.206964990054, 5471.261379713767, 5500.58745594082, 5506.201600767947, 5525.198846167364, 3732.925341493209, 4840.419149702058, 5011.398632164163, 5012.824551140692, 5018.623603229772, 4020.0552870075508, 4074.3684728867074, 4080.4858331526057, 4109.8972525687095, 4116.773577453268, 1328.0504439325928, 1331.1414137881013, 1331.2012792324722, 1340.222670850904, 1347.6967682271606, 1109.1514991031868, 1164.1559869094838, 1176.2178151529138, 1250.1561446023898, 1370.7943808428615, 8047.758567242992, 8084.3936704747375, 8124.187581241828, 8128.146544612849, 8157.877631835528, 506.8150125204348, 516.6460974232663, 517.4825174825174, 519.1175002495772, 522.27925462861, 6337.144485494491, 6360.332165122688, 6422.133012043408, 6466.4503517201565, 6516.120323756327, 10535.578576856993, 10811.0, 10876.238663293652, 10877.728056798485, 11000.614978475714, 10712.78574428507, 10720.517576709066, 10766.89233107659, 10956.233063685624, 11305.660830175108, 8242.629081691339, 8268.503889766633, 8319.417640765208, 8329.208725171098, 8333.708320208763, 6921.826954326182, 8042.437029407885, 8455.112213217524, 8457.661693532189, 8476.025257095513, 7744.535327880345, 9466.05339466048, 9548.18840398574, 9768.120869121813, 9829.0, 9661.323707340418, 9892.159166470643, 10007.399556026661, 10051.145652619316, 10108.241881858743, 6717.261101278953, 7385.889211661937, 7476.775696729107, 7508.43686723487, 7774.961125194564, 8510.531920744172, 8520.403571749917, 8556.401051926554, 8575.056743758307, 8588.785280368042, 7467.290607392289, 7594.164641889498, 7642.04474440695, 7678.232176782501, 7739.5743234122665, 7383.372413344711, 7506.962465187639, 7552.584607846621, 7619.885701714589, 7633.274838890296, 7810.3751699865015, 7908.6441110149035, 7950.801229969297, 7956.2441568050945, 8053.557054362066, 7062.576245425291, 7101.680424381018, 7145.964270178616, 7181.676824543013, 7182.928170718226, 6123.4488895999575, 7110.5022648414115, 7246.818829529304, 7250.057492525938, 7301.123865136005], "value": 4857.528638751471, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.895845933153, 325.8321964188443, 332.5875913866806, 334.86940093363586, 340.02921658664513, 6023.668698221596, 6141.447269745722, 6157.4275280870825, 6159.8768024639485, 6207.720652570634, 6003.847979810602, 6025.444987457399, 6055.212822333102, 6067.4842638375685, 6085.452309292163, 3968.960310396888, 4107.342825147977, 4534.1158474097565, 4552.499225085238, 4625.236835922069, 4003.2794097062515, 4510.300903359985, 4523.434570678665, 4535.682502224846, 4593.379893714356, 4168.291390463629, 4507.797149128281, 4520.615747661453, 4548.749818759967, 4570.177368073745, 4397.31841564558, 4550.794039579514, 4554.86335409935, 4592.862214133581, 4607.285870690049, 3446.879359222415, 3619.457081437779, 3876.0, 3932.016995751062, 3955.8417663293435, 5038.294638750541, 5768.836686242659, 5806.390329015477, 5829.271341082364, 5837.88324233513, 5143.254228136937, 5161.27742116104, 5188.962207558503, 5343.759530821084, 5354.491323324278, 4843.4914333994775, 4948.356713627241, 5783.277090363705, 6335.271443783978, 6419.165508483914, 3794.620537946211, 3818.4654148419245, 4279.7218180818145, 4346.239408103569, 4361.127774445124, 6579.9671001645165, 6663.400293973517, 6726.544811143946, 6762.0, 6785.728570857111, 3697.2605478904325, 4377.387165796791, 4418.6023257906945, 4430.645548356124, 4467.262901621196, 4526.841560545365, 4530.592246697813, 4536.637069034469, 4543.750093744809, 4546.545345465427, 4664.230401983635, 5027.572656324181, 5306.893862122736, 5314.388845282765, 5327.627066105335, 5508.669479831223, 6304.6445014321225, 6465.935340646627, 6498.935010649833, 6534.509911756637, 1405.6345350208815, 1549.457689808558, 1565.6320764620305, 1566.4752307976728, 1573.0, 881.7310720230263, 882.885224920769, 884.1379654836483, 965.358036905464, 981.489625394805, 5896.410358964155, 5941.643501389931, 5952.3154837193415, 5973.313068997034, 5976.850578735566, 5500.697461639568, 6616.0, 6638.86722265552, 6639.170103737033, 6665.266820649725, 4989.725565093955, 5694.352126261226, 5871.765129394862, 6001.769637224358, 6015.428534289235, 3474.652534746556, 3504.684578387957, 3516.7889926604485, 3535.098549869767, 3536.929261414809, 5808.854778630568, 6794.150731158606, 6839.829004274833, 6903.549240019821, 6929.7228110875, 6449.419552240321, 6747.831304217434, 6750.696218670171, 6780.525363224626, 6836.111305530349, 6720.8319792005595, 6814.454843612598, 6908.792736217922, 6916.412104971134, 6995.825104372431, 6595.142631458071, 6645.833854153685, 6680.231773345933, 6689.76585819494, 6719.748884123873, 5636.3799982002765, 6268.780592679234, 6517.674116294261, 6521.64130972801, 6575.605463672195, 6018.849528761816, 6120.938790612215, 6864.725410983505, 6866.189264957797, 6888.655567221719, 4099.713020088565, 4315.4605674290715, 4319.766628703825, 4342.956570434255, 4353.477582690098, 6041.395860413923, 6227.346128656607, 6427.778722042797, 6617.735290588515, 6671.232808226922, 6402.711877965409, 6408.840883089158, 6448.258450278278, 6454.225492940877, 6495.480361570969, 5341.973290133525, 6128.571000029955, 6437.227532696106, 6450.8064758057335, 6477.676116194266, 6008.969955150196, 6128.509719222362, 6239.251289845248, 6285.277193122849, 6321.715522801393, 6409.935900640934, 6448.677566121769, 6470.288268290578, 6495.902561461677, 6508.674566271573, 5272.604554658339, 6089.847753806191, 6330.683465826598, 6358.55195749649, 6410.775622853178], "value": 4671.271143803125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1974875927422, 676.2459857259156, 747.4020783373302, 766.0883548577193, 784.7326567593335, 14738.778918316233, 14921.626959325995, 15183.924080379611, 15199.544013679593, 15254.161021143833, 12852.16460930039, 12947.676308092303, 12949.805752913713, 12961.611151665442, 13102.27937463439, 717.7774889784183, 803.6704950970103, 904.9457032578066, 926.2497377124517, 939.8496240601505, 879.2043200903192, 918.6233644205877, 926.9907300926972, 927.4528028463205, 928.5218112671979, 934.8691183234353, 975.4829940131741, 981.950902454878, 984.4782265399314, 986.39336807863, 927.5872236854602, 953.3707752883098, 961.9086186812242, 976.3995142987083, 977.0571398600349, 695.4644923408947, 705.1714235772946, 716.6918225163178, 732.1251104929611, 732.8351120997786, 14986.10083394989, 15058.0, 15128.092314461057, 15140.318685659062, 15166.014209076375, 10538.473076346152, 12825.23048617086, 12892.0, 13135.671608209776, 13221.801672974912, 9811.313208075437, 10088.69733907984, 10112.797744045152, 10424.895751042544, 10494.265401421904, 3455.706264967481, 3482.2165012872156, 3489.145159435929, 3499.7725147865563, 3502.824858757052, 71071.57856842886, 74099.5180096395, 74377.62811185964, 75646.62176689136, 81151.0, 9261.583228754722, 9398.812023759487, 9537.427754334762, 9575.99452057538, 9618.422894626345, 20824.687629685566, 20969.370918872457, 20999.160033598484, 21102.155913763585, 21193.894030530057, 6087.847803804941, 7099.964500177466, 7402.888956665654, 7727.150013498623, 7821.608919554, 3451.7238620910266, 4057.0, 4096.365063415175, 4100.569440208795, 4105.3020986432375, 3501.7548771586253, 3610.693091087287, 3624.456331550236, 3635.4546817976984, 3639.1084184375, 611.1382950040422, 619.8842084248334, 634.1597383466925, 634.7461015593707, 635.9618422894641, 477.808876449423, 573.9253896993364, 607.817654703596, 611.5963464113663, 615.8141468944375, 6719.328067193242, 7830.138684744674, 7988.840223195503, 8005.0, 8272.958635206785, 510.2295533744073, 551.9282493275848, 582.5872259770041, 583.8773857489974, 584.2521572387351, 3798.582155962842, 3818.4654148419245, 3891.9416208756893, 3908.9413658795143, 3988.980055099706, 81410.18589814026, 81617.59191204006, 83268.16731832604, 83318.16681833225, 83819.5809020951, 70024.64987675029, 70208.0, 70623.58752825018, 70796.0, 72016.0, 63212.0, 65547.36131596843, 65605.67197163984, 65755.67122164358, 66011.00983485156, 7454.105507339154, 7506.3244308012545, 7632.80917977055, 7684.385249180164, 7728.7681369559, 40609.79695101506, 41896.16207675768, 42398.788006059774, 42550.78724606357, 44142.0, 52315.73842130917, 55132.72433637806, 55867.0, 56575.58561035842, 56604.433955659915, 8246.917530824616, 9666.178374838217, 9878.604855805686, 10005.699829005142, 10067.496625168566, 10557.788844223227, 10572.524236409226, 10761.623343182951, 10781.892181078403, 10856.61523798176, 10272.075513203847, 10316.17470602335, 10329.173666106844, 10665.573377064831, 10694.679159625224, 10106.747331316776, 10197.898021019695, 10240.53917573696, 10281.228907831794, 10571.841422378824, 10144.442055687008, 10177.18582513412, 10212.795744085226, 10345.586176553155, 10556.313839600401, 8788.07725188846, 8859.822803544022, 8931.910680893368, 9123.817523649357, 9161.541922903962, 8687.869681954902, 8908.643654253758, 8937.06160853127, 8973.833401657743, 8975.147361000694], "value": 6580.569187115071, "unit": "score"}], "name": "dromaeo_css", "value": 7290.611755999947, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 157.0, 99.0, 173.0, 171.0, 185.0, 114.0, 116.0, 117.0, 117.0], "value": 142.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 144.0, 184.0, 162.0, 131.0, 171.0, 133.0, 156.0, 208.0, 151.0], "value": 159.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 232.0, 199.0, 200.0, 199.0, 197.0, 199.0, 201.0, 203.0, 195.0], "value": 202.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 74.0, 132.0, 55.0, 56.0, 66.0, 59.0, 79.0, 80.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 123.0, 78.0, 82.0, 90.0, 123.0, 79.0, 83.0, 125.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 123.0, 88.0, 88.0, 79.0, 115.0, 134.0, 109.0, 118.0, 131.0], "value": 111.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 110.0, 149.0, 95.0, 93.0, 94.0, 94.0, 95.0, 94.0, 103.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 93.0, 93.0, 97.0, 150.0, 93.0, 115.0, 144.0, 95.0], "value": 117.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 58.0, 56.0, 57.0, 57.0, 75.0, 67.0, 79.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 73.0, 65.0, 70.0, 73.0, 71.0, 68.0, 66.0, 70.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 92.0, 113.0, 113.0, 87.0, 91.0, 90.0, 89.0, 88.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 164.0, 153.0, 168.0, 165.0, 166.0, 167.0, 211.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 177.0, 175.0, 175.0, 174.0, 190.0, 174.0, 170.0, 173.0], "value": 175.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 71.0, 67.0, 75.0, 72.0, 73.0, 69.0, 69.0, 70.0], "value": 70.8, "unit": "score"}], "name": "kraken", "value": 1641.4999999999998, "alertThreshold": 2.0}]} 05:55:15 INFO - Return code: 0 05:55:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:55:15 ERROR - # TBPL SUCCESS # 05:55:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:55:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:55:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:55:15 INFO - 2016-04-12 05:55:15.632 screenresolution[1689:10619] starting screenresolution argv=screenresolution get 05:55:15 INFO - 2016-04-12 05:55:15.634 screenresolution[1689:10619] Display 0: 1600x1200x32@60 05:55:15 INFO - 2016-04-12 05:55:15.640 screenresolution[1690:10622] starting screenresolution argv=screenresolution list 05:55:15 INFO - Available Modes on Display 0 05:55:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:55:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:55:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:55:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:55:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:55:15 INFO - Intel Iris: 05:55:15 INFO - Chipset Model: Intel Iris 05:55:15 INFO - Type: GPU 05:55:15 INFO - Bus: Built-In 05:55:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:55:15 INFO - Vendor: Intel (0x8086) 05:55:15 INFO - Device ID: 0x0a2e 05:55:15 INFO - Revision ID: 0x0009 05:55:15 INFO - Displays: 05:55:15 INFO - Display: 05:55:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:55:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:55:15 INFO - Display Serial Number: 1600x1200 60 05:55:15 INFO - Main Display: Yes 05:55:15 INFO - Mirror: Off 05:55:15 INFO - Online: Yes 05:55:15 INFO - Rotation: Supported 05:55:15 INFO - Return code: 0 05:55:15 INFO - Running post-action listener: _resource_record_post_action 05:55:15 INFO - Running post-run listener: _resource_record_post_run 05:55:16 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 38589952; Write bytes: 697322496; Read time: 399; Write time: 2233 05:55:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377496064; Write bytes: 371680768; Read time: 28635; Write time: 742 05:55:16 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 37627392; Write bytes: 302708224; Read time: 384; Write time: 1443 05:55:16 INFO - Running post-run listener: _upload_blobber_files 05:55:16 INFO - Blob upload gear active. 05:55:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:55:16 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 05:55:16 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'] 05:55:16 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 05:55:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:55:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:55:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:55:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:18 INFO - (blobuploader) - INFO - Done attempting. 05:55:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:55:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:55:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:55:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:55:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:55:19 INFO - (blobuploader) - INFO - Done attempting. 05:55:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:55:19 INFO - Return code: 0 05:55:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:55:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:55:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f43dfc8ed4271d78134698bdd160aa77aabb5df571e1c76e832f7c60ad89b793718bf236a0c221ddc2dcda504f9918617a8ab00671c00d9128eb9462f995a0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45ed3e788ae79bb66bb5d7969b8a76e48d12b7a16aa16380b15bdfcdb735c61089f279de0339bdbf090b42f786f9ecc0c7a955c13890f168b64e9931051a4d1"} 05:55:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:55:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:55:19 INFO - Contents: 05:55:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f43dfc8ed4271d78134698bdd160aa77aabb5df571e1c76e832f7c60ad89b793718bf236a0c221ddc2dcda504f9918617a8ab00671c00d9128eb9462f995a0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45ed3e788ae79bb66bb5d7969b8a76e48d12b7a16aa16380b15bdfcdb735c61089f279de0339bdbf090b42f786f9ecc0c7a955c13890f168b64e9931051a4d1"} 05:55:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:55:19 INFO - Copying logs to upload dir... 05:55:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:55:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.690873 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-04-12 05:55:19.190215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:55:19.195727) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f43dfc8ed4271d78134698bdd160aa77aabb5df571e1c76e832f7c60ad89b793718bf236a0c221ddc2dcda504f9918617a8ab00671c00d9128eb9462f995a0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45ed3e788ae79bb66bb5d7969b8a76e48d12b7a16aa16380b15bdfcdb735c61089f279de0339bdbf090b42f786f9ecc0c7a955c13890f168b64e9931051a4d1"} build_url:https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011118 build_url: 'https://queue.taskcluster.net/v1/task/arQDauJ2S7Cii_l4E_7FAg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f43dfc8ed4271d78134698bdd160aa77aabb5df571e1c76e832f7c60ad89b793718bf236a0c221ddc2dcda504f9918617a8ab00671c00d9128eb9462f995a0f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45ed3e788ae79bb66bb5d7969b8a76e48d12b7a16aa16380b15bdfcdb735c61089f279de0339bdbf090b42f786f9ecc0c7a955c13890f168b64e9931051a4d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:55:19.223080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:55:19.223452) ========= 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.oekLaku1nf/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.OI09c984nG/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005178 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:55:19.272473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:55:19.272824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:55:19.273255) ========= ========= Total master_lag: 0.27 =========