builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1457719013.81 results: success (0) buildid: 20160311081313 builduid: a5785301380c40699fae11e9e5123763 revision: 946ed22cad04431c75ab5093989dfedf1bae5a3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.810136) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.810672) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.810990) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005573 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.836392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.836770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.853993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.854351) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005481 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.902502) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.902836) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.903207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:53.903488) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-11 09:56:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.2M=0s 2016-03-11 09:56:54 (28.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.330324 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:54.249939) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:54.250264) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.025625 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:54.299401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 09:56:54.299765) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 946ed22cad04431c75ab5093989dfedf1bae5a3e --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 946ed22cad04431c75ab5093989dfedf1bae5a3e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-11 09:56:54,568 truncating revision to first 12 chars 2016-03-11 09:56:54,568 Setting DEBUG logging. 2016-03-11 09:56:54,568 attempt 1/10 2016-03-11 09:56:54,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/946ed22cad04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 09:56:55,383 unpacking tar archive at: mozilla-central-946ed22cad04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.068315 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 09:56:55.385090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:55.385457) ========= echo 946ed22cad04431c75ab5093989dfedf1bae5a3e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'946ed22cad04431c75ab5093989dfedf1bae5a3e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 946ed22cad04431c75ab5093989dfedf1bae5a3e program finished with exit code 0 elapsedTime=0.005585 script_repo_revision: '946ed22cad04431c75ab5093989dfedf1bae5a3e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:55.435806) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:55.436132) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 09:56:55.449581) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-11 09:56:55.449928) ========= /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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:56:55 INFO - MultiFileLogger online at 20160311 09:56:55 in /builds/slave/test 09:56:55 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 09:56:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:55 INFO - {'append_to_log': False, 09:56:55 INFO - 'base_work_dir': '/builds/slave/test', 09:56:55 INFO - 'blob_upload_branch': 'Firefox', 09:56:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:55 INFO - 'branch': 'Firefox', 09:56:55 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:55 INFO - 'config_files': ('talos/mac_config.py',), 09:56:55 INFO - 'default_actions': ('clobber', 09:56:55 INFO - 'read-buildbot-config', 09:56:55 INFO - 'download-and-extract', 09:56:55 INFO - 'populate-webroot', 09:56:55 INFO - 'create-virtualenv', 09:56:55 INFO - 'install', 09:56:55 INFO - 'run-tests'), 09:56:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:55 INFO - 'download_minidump_stackwalk': True, 09:56:55 INFO - 'download_symbols': 'ondemand', 09:56:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:55 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:55 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:55 INFO - 'installer_path': 'installer.exe', 09:56:55 INFO - 'log_level': 'info', 09:56:55 INFO - 'log_name': 'talos', 09:56:55 INFO - 'log_to_console': True, 09:56:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:56:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:56:55 INFO - 'opt_config_files': (), 09:56:55 INFO - 'pip_index': False, 09:56:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:55 INFO - 'cmd': ('bash', 09:56:55 INFO - '-c', 09:56:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:55 INFO - 'enabled': True, 09:56:55 INFO - 'halt_on_failure': False, 09:56:55 INFO - 'name': 'check_screen_resolution'},), 09:56:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:56:55 INFO - 'cmd': ('bash', 09:56:55 INFO - '-c', 09:56:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:56:55 INFO - 'enabled': True, 09:56:55 INFO - 'halt_on_failure': False, 09:56:55 INFO - 'name': 'check_screen_resolution'},), 09:56:55 INFO - 'run_cmd_checks_enabled': True, 09:56:55 INFO - 'sps_profile': False, 09:56:55 INFO - 'sps_profile_interval': 0, 09:56:55 INFO - 'suite': 'dromaeojs-e10s', 09:56:55 INFO - 'system_bits': '32', 09:56:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:55 INFO - 'title': 't-yosemite-r7-0163', 09:56:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:55 INFO - 'use_talos_json': True, 09:56:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:55 INFO - 'work_dir': 'build'} 09:56:55 INFO - ##### 09:56:55 INFO - ##### Running clobber step. 09:56:55 INFO - ##### 09:56:55 INFO - Running pre-action listener: _resource_record_pre_action 09:56:55 INFO - Running main action method: clobber 09:56:55 INFO - rmtree: /builds/slave/test/build 09:56:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:57 INFO - Running post-action listener: _resource_record_post_action 09:56:57 INFO - ##### 09:56:57 INFO - ##### Running read-buildbot-config step. 09:56:57 INFO - ##### 09:56:57 INFO - Running pre-action listener: _resource_record_pre_action 09:56:57 INFO - Running main action method: read_buildbot_config 09:56:57 INFO - Using buildbot properties: 09:56:57 INFO - { 09:56:57 INFO - "project": "", 09:56:57 INFO - "product": "firefox", 09:56:57 INFO - "script_repo_revision": "production", 09:56:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:56:57 INFO - "repository": "", 09:56:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:56:57 INFO - "buildid": "20160311081313", 09:56:57 INFO - "pgo_build": "False", 09:56:57 INFO - "basedir": "/builds/slave/test", 09:56:57 INFO - "buildnumber": 184, 09:56:57 INFO - "slavename": "t-yosemite-r7-0163", 09:56:57 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:56:57 INFO - "platform": "yosemite_r7", 09:56:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:56:57 INFO - "branch": "mozilla-central", 09:56:57 INFO - "repo_path": "mozilla-central", 09:56:57 INFO - "revision": "946ed22cad04431c75ab5093989dfedf1bae5a3e", 09:56:57 INFO - "stage_platform": "macosx64", 09:56:57 INFO - "builduid": "a5785301380c40699fae11e9e5123763", 09:56:57 INFO - "slavebuilddir": "test" 09:56:57 INFO - } 09:56:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 09:56:57 INFO - Running post-action listener: _resource_record_post_action 09:56:57 INFO - ##### 09:56:57 INFO - ##### Running download-and-extract step. 09:56:57 INFO - ##### 09:56:57 INFO - Running pre-action listener: _resource_record_pre_action 09:56:57 INFO - Running main action method: download_and_extract 09:56:57 INFO - mkdir: /builds/slave/test/build/tests 09:56:57 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')]} 09:56:57 INFO - https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:56:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:56:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:56:58 INFO - Downloaded 1199 bytes. 09:56:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 09:56:58 INFO - Using the following test package requirements: 09:56:58 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:56:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 09:56:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 09:56:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'jsshell-mac.zip'], 09:56:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 09:56:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 09:56:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 09:56:58 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 09:56:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 09:56:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 09:56:58 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 09:56:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:56:58 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')]} 09:56:58 INFO - https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:56:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:56:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:56:59 INFO - Downloaded 17865064 bytes. 09:56:59 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'] 09:56:59 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 09:57:02 INFO - Return code: 0 09:57:02 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 09:57:02 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')]} 09:57:02 INFO - https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:57:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 09:57:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:57:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:57:03 INFO - Downloaded 17865064 bytes. 09:57:03 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'] 09:57:03 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 09:57:07 INFO - Return code: 0 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:07 INFO - https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:57:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:57:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 09:57:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:57:09 INFO - Downloaded 10845263 bytes. 09:57:09 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'] 09:57:09 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 09:57:09 INFO - Return code: 0 09:57:09 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')]} 09:57:09 INFO - https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:57:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 09:57:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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 09:57:12 INFO - Downloaded 111025396 bytes. 09:57:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:12 INFO - mkdir: /builds/slave/test/properties 09:57:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:12 INFO - Contents: 09:57:12 INFO - build_url:https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 09:57:13 INFO - Running post-action listener: _resource_record_post_action 09:57:13 INFO - Running post-action listener: set_extra_try_arguments 09:57:13 INFO - ##### 09:57:13 INFO - ##### Running populate-webroot step. 09:57:13 INFO - ##### 09:57:13 INFO - Running pre-action listener: _resource_record_pre_action 09:57:13 INFO - Running main action method: populate_webroot 09:57:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:13 INFO - '--tppagecycles', 09:57:13 INFO - '7'], 09:57:13 INFO - 'tests': ['tsvgm']}}, 09:57:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:57:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:57:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'tests': ['damp', 'tps']}, 09:57:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['damp', 'tps']}, 09:57:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:13 INFO - 'other': {'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'other_l64': {'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:13 INFO - 'ts_paint', 09:57:13 INFO - 'tpaint', 09:57:13 INFO - 'sessionrestore', 09:57:13 INFO - 'sessionrestore_no_auto_restore', 09:57:13 INFO - 'tabpaint']}, 09:57:13 INFO - 'svgr': {'tests': ['tsvgx', 09:57:13 INFO - 'tsvgr_opacity', 09:57:13 INFO - 'tart', 09:57:13 INFO - 'tscrollx', 09:57:13 INFO - 'cart']}, 09:57:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['tsvgx', 09:57:13 INFO - 'tsvgr_opacity', 09:57:13 INFO - 'tart', 09:57:13 INFO - 'tscrollx', 09:57:13 INFO - 'cart']}, 09:57:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'tests': ['tp5o']}, 09:57:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'talos_options': ['--e10s'], 09:57:13 INFO - 'tests': ['tp5o']}, 09:57:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'talos_options': ['--xperf_path', 09:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:13 INFO - 'tests': ['tp5n']}, 09:57:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:13 INFO - 'talos_options': ['--e10s', 09:57:13 INFO - '--xperf_path', 09:57:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:13 INFO - 'tests': ['tp5n']}}, 09:57:13 INFO - 'talos.zip': {'path': '', 09:57:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:13 INFO - Running post-action listener: _resource_record_post_action 09:57:13 INFO - ##### 09:57:13 INFO - ##### Running create-virtualenv step. 09:57:13 INFO - ##### 09:57:13 INFO - Running pre-action listener: _resource_record_pre_action 09:57:13 INFO - Running main action method: create_virtualenv 09:57:13 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:57:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:13 INFO - Using real prefix '/tools/python27' 09:57:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:14 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:17 INFO - Installing pip.................done. 09:57:17 INFO - Return code: 0 09:57:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:17 INFO - 'HOME': '/Users/cltbld', 09:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:17 INFO - 'LOGNAME': 'cltbld', 09:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:17 INFO - 'MOZ_NO_REMOTE': '1', 09:57:17 INFO - 'NO_EM_RESTART': '1', 09:57:17 INFO - 'PAGER': '/bin/cat', 09:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:17 INFO - 'PWD': '/builds/slave/test', 09:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:17 INFO - 'SHELL': '/bin/bash', 09:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:17 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:17 INFO - 'USER': 'cltbld', 09:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:17 INFO - 'XPC_FLAGS': '0x0', 09:57:17 INFO - 'XPC_SERVICE_NAME': '0', 09:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:57:17 INFO - Cleaning up... 09:57:17 INFO - Return code: 0 09:57:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:17 INFO - 'HOME': '/Users/cltbld', 09:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:17 INFO - 'LOGNAME': 'cltbld', 09:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:17 INFO - 'MOZ_NO_REMOTE': '1', 09:57:17 INFO - 'NO_EM_RESTART': '1', 09:57:17 INFO - 'PAGER': '/bin/cat', 09:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:17 INFO - 'PWD': '/builds/slave/test', 09:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:17 INFO - 'SHELL': '/bin/bash', 09:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:17 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:17 INFO - 'USER': 'cltbld', 09:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:17 INFO - 'XPC_FLAGS': '0x0', 09:57:17 INFO - 'XPC_SERVICE_NAME': '0', 09:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:17 INFO - Downloading/unpacking psutil>=0.7.1 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:17 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 09:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:20 INFO - Installing collected packages: psutil 09:57:20 INFO - Running setup.py install for psutil 09:57:20 INFO - building 'psutil._psutil_osx' extension 09:57:20 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 09:57:21 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 09:57:21 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 09:57:21 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 09:57:21 INFO - building 'psutil._psutil_posix' extension 09:57:21 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 09:57:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:57:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:57:21 INFO - ^ 09:57:21 INFO - 1 warning generated. 09:57:21 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 09:57:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:21 INFO - Successfully installed psutil 09:57:21 INFO - Cleaning up... 09:57:21 INFO - Return code: 0 09:57:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:21 INFO - 'HOME': '/Users/cltbld', 09:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:21 INFO - 'LOGNAME': 'cltbld', 09:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:21 INFO - 'MOZ_NO_REMOTE': '1', 09:57:21 INFO - 'NO_EM_RESTART': '1', 09:57:21 INFO - 'PAGER': '/bin/cat', 09:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:21 INFO - 'PWD': '/builds/slave/test', 09:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:21 INFO - 'SHELL': '/bin/bash', 09:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:21 INFO - 'USER': 'cltbld', 09:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:21 INFO - 'XPC_FLAGS': '0x0', 09:57:21 INFO - 'XPC_SERVICE_NAME': '0', 09:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:22 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 09:57:22 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 09:57:22 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 09:57:22 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 09:57:22 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 09:57:22 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 09:57:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:24 INFO - Installing collected packages: mozsystemmonitor 09:57:24 INFO - Running setup.py install for mozsystemmonitor 09:57:24 INFO - Successfully installed mozsystemmonitor 09:57:24 INFO - Cleaning up... 09:57:24 INFO - Return code: 0 09:57:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:24 INFO - 'HOME': '/Users/cltbld', 09:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:24 INFO - 'LOGNAME': 'cltbld', 09:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:24 INFO - 'MOZ_NO_REMOTE': '1', 09:57:24 INFO - 'NO_EM_RESTART': '1', 09:57:24 INFO - 'PAGER': '/bin/cat', 09:57:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:24 INFO - 'PWD': '/builds/slave/test', 09:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:24 INFO - 'SHELL': '/bin/bash', 09:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:24 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:24 INFO - 'USER': 'cltbld', 09:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:24 INFO - 'XPC_FLAGS': '0x0', 09:57:24 INFO - 'XPC_SERVICE_NAME': '0', 09:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:24 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:27 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 09:57:28 INFO - Downloading docopt-0.6.1.tar.gz 09:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:28 INFO - Running setup.py install for blobuploader 09:57:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:28 INFO - Running setup.py install for requests 09:57:29 INFO - Running setup.py install for docopt 09:57:29 INFO - Successfully installed blobuploader requests docopt 09:57:29 INFO - Cleaning up... 09:57:29 INFO - Return code: 0 09:57:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:29 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')]} 09:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 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')]} 09:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:29 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 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:29 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 09:57:29 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 09:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:29 INFO - 'HOME': '/Users/cltbld', 09:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:29 INFO - 'LOGNAME': 'cltbld', 09:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:29 INFO - 'MOZ_NO_REMOTE': '1', 09:57:29 INFO - 'NO_EM_RESTART': '1', 09:57:29 INFO - 'PAGER': '/bin/cat', 09:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:29 INFO - 'PWD': '/builds/slave/test', 09:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:29 INFO - 'SHELL': '/bin/bash', 09:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:29 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:29 INFO - 'USER': 'cltbld', 09:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:29 INFO - 'XPC_FLAGS': '0x0', 09:57:29 INFO - 'XPC_SERVICE_NAME': '0', 09:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:29 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PazYbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:29 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-rkFU62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:29 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-U9A_Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:29 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MAaUss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-H_BfXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UKniFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dJmpdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RLNPUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-h6bDZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-e0_jBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-FIRrhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xrujYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:30 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VnCv6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ls0v03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-no_bqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-lpbnRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:31 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6FKv6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:31 INFO - Running setup.py install for manifestparser 09:57:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:31 INFO - Running setup.py install for mozcrash 09:57:31 INFO - Running setup.py install for mozdebug 09:57:31 INFO - Running setup.py install for mozdevice 09:57:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Running setup.py install for mozfile 09:57:32 INFO - Running setup.py install for mozhttpd 09:57:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Running setup.py install for mozinfo 09:57:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Running setup.py install for mozInstall 09:57:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Running setup.py install for mozleak 09:57:32 INFO - Running setup.py install for mozlog 09:57:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:32 INFO - Running setup.py install for moznetwork 09:57:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Running setup.py install for mozprocess 09:57:33 INFO - Running setup.py install for mozprofile 09:57:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Running setup.py install for mozrunner 09:57:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Running setup.py install for mozscreenshot 09:57:33 INFO - Running setup.py install for moztest 09:57:33 INFO - Running setup.py install for mozversion 09:57:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:33 INFO - Cleaning up... 09:57:34 INFO - Return code: 0 09:57:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:34 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 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:34 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 09:57:34 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 09:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:34 INFO - 'HOME': '/Users/cltbld', 09:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:34 INFO - 'LOGNAME': 'cltbld', 09:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:34 INFO - 'MOZ_NO_REMOTE': '1', 09:57:34 INFO - 'NO_EM_RESTART': '1', 09:57:34 INFO - 'PAGER': '/bin/cat', 09:57:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:34 INFO - 'PWD': '/builds/slave/test', 09:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:34 INFO - 'SHELL': '/bin/bash', 09:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:34 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:34 INFO - 'USER': 'cltbld', 09:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:34 INFO - 'XPC_FLAGS': '0x0', 09:57:34 INFO - 'XPC_SERVICE_NAME': '0', 09:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TtwdNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ATFirC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VMkmHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-G_eIPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-zsFLmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-mSMwOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:34 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)) 09:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YRmFcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-PizkLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gBXgIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oAWWpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Yu_u57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ZLLCAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-hLLclj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-JKpmfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1XrZvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3RS1WI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:35 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)) 09:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Ry5UaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:36 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)) 09:57:36 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)) 09:57:36 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)) 09:57:36 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)) 09:57:36 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)) 09:57:36 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)) 09:57:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:38 INFO - Downloading blessings-1.6.tar.gz 09:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:38 INFO - Installing collected packages: blessings 09:57:38 INFO - Running setup.py install for blessings 09:57:38 INFO - Successfully installed blessings 09:57:38 INFO - Cleaning up... 09:57:38 INFO - Return code: 0 09:57:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:39 INFO - Reading from file tmpfile_stdout 09:57:39 INFO - Current package versions: 09:57:39 INFO - blessings == 1.6 09:57:39 INFO - blobuploader == 1.2.4 09:57:39 INFO - docopt == 0.6.1 09:57:39 INFO - manifestparser == 1.1 09:57:39 INFO - mozInstall == 1.12 09:57:39 INFO - mozcrash == 0.17 09:57:39 INFO - mozdebug == 0.1 09:57:39 INFO - mozdevice == 0.48 09:57:39 INFO - mozfile == 1.2 09:57:39 INFO - mozhttpd == 0.7 09:57:39 INFO - mozinfo == 0.9 09:57:39 INFO - mozleak == 0.1 09:57:39 INFO - mozlog == 3.1 09:57:39 INFO - moznetwork == 0.27 09:57:39 INFO - mozprocess == 0.22 09:57:39 INFO - mozprofile == 0.28 09:57:39 INFO - mozrunner == 6.11 09:57:39 INFO - mozscreenshot == 0.1 09:57:39 INFO - mozsystemmonitor == 0.0 09:57:39 INFO - moztest == 0.7 09:57:39 INFO - mozversion == 1.4 09:57:39 INFO - psutil == 3.1.1 09:57:39 INFO - requests == 1.2.3 09:57:39 INFO - wsgiref == 0.1.2 09:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:39 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 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:39 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 09:57:39 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 09:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:39 INFO - 'HOME': '/Users/cltbld', 09:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:39 INFO - 'LOGNAME': 'cltbld', 09:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:39 INFO - 'MOZ_NO_REMOTE': '1', 09:57:39 INFO - 'NO_EM_RESTART': '1', 09:57:39 INFO - 'PAGER': '/bin/cat', 09:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:39 INFO - 'PWD': '/builds/slave/test', 09:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:39 INFO - 'SHELL': '/bin/bash', 09:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:39 INFO - 'USER': 'cltbld', 09:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:39 INFO - 'XPC_FLAGS': '0x0', 09:57:39 INFO - 'XPC_SERVICE_NAME': '0', 09:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 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)) 09:57:39 INFO - Cleaning up... 09:57:39 INFO - Return code: 0 09:57:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:57:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:57:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:39 INFO - 'HOME': '/Users/cltbld', 09:57:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:39 INFO - 'LOGNAME': 'cltbld', 09:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:39 INFO - 'MOZ_NO_REMOTE': '1', 09:57:39 INFO - 'NO_EM_RESTART': '1', 09:57:39 INFO - 'PAGER': '/bin/cat', 09:57:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:39 INFO - 'PWD': '/builds/slave/test', 09:57:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:39 INFO - 'SHELL': '/bin/bash', 09:57:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:39 INFO - 'USER': 'cltbld', 09:57:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:39 INFO - 'XPC_FLAGS': '0x0', 09:57:39 INFO - 'XPC_SERVICE_NAME': '0', 09:57:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:39 INFO - Downloading/unpacking jsonschema 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:57:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:57:41 INFO - Downloading/unpacking functools32 (from jsonschema) 09:57:41 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 09:57:41 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 09:57:41 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 09:57:41 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 09:57:41 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 09:57:41 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 09:57:42 INFO - Downloading functools32-3.2.3-2.tar.gz 09:57:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:57:42 INFO - warning: no files found matching '*.txt' 09:57:42 INFO - no previously-included directories found matching 'build' 09:57:42 INFO - no previously-included directories found matching 'dist' 09:57:42 INFO - no previously-included directories found matching '.git*' 09:57:42 INFO - Installing collected packages: jsonschema, functools32 09:57:42 INFO - Running setup.py install for functools32 09:57:42 INFO - warning: no files found matching '*.txt' 09:57:42 INFO - no previously-included directories found matching 'build' 09:57:42 INFO - no previously-included directories found matching 'dist' 09:57:42 INFO - no previously-included directories found matching '.git*' 09:57:42 INFO - Successfully installed jsonschema functools32 09:57:42 INFO - Cleaning up... 09:57:42 INFO - Return code: 0 09:57:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:57: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')]} 09:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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')]} 09:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f51a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f584c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54ad63c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, '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.gCNBkMhIda/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.yEB4FcL6hM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 09:57: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', 'flake8'] in /builds/slave/test/build 09:57: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 flake8 09:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:57:42 INFO - 'HOME': '/Users/cltbld', 09:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:57:42 INFO - 'LOGNAME': 'cltbld', 09:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:42 INFO - 'MOZ_NO_REMOTE': '1', 09:57:42 INFO - 'NO_EM_RESTART': '1', 09:57:42 INFO - 'PAGER': '/bin/cat', 09:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:42 INFO - 'PWD': '/builds/slave/test', 09:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:57:42 INFO - 'SHELL': '/bin/bash', 09:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:57:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:57:42 INFO - 'USER': 'cltbld', 09:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:42 INFO - 'XPC_FLAGS': '0x0', 09:57:42 INFO - 'XPC_SERVICE_NAME': '0', 09:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:42 INFO - Downloading/unpacking flake8 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:57: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 09:58:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:58:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:58:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:06 INFO - no previously-included directories found matching 'docs/_build' 09:58:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:58:06 INFO - Running setup.py install for pep8 09:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:58:06 INFO - no previously-included directories found matching 'docs/_build' 09:58:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:58:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:58:06 INFO - Cleaning up... 09:58:06 INFO - Return code: 0 09:58:06 INFO - Running post-action listener: _resource_record_post_action 09:58:06 INFO - Running post-action listener: _start_resource_monitoring 09:58:06 INFO - Starting resource monitoring. 09:58:06 INFO - ##### 09:58:06 INFO - ##### Running install step. 09:58:06 INFO - ##### 09:58:06 INFO - Running pre-action listener: _resource_record_pre_action 09:58:06 INFO - Running main action method: install 09:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:06 INFO - Reading from file tmpfile_stdout 09:58:06 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:06 INFO - Reading from file tmpfile_stdout 09:58:06 INFO - Output received: 09:58:06 INFO - Usage: mozinstall [options] installer 09:58:06 INFO - Options: 09:58:06 INFO - -h, --help show this help message and exit 09:58:06 INFO - -d DEST, --destination=DEST 09:58:06 INFO - Directory to install application into. [default: 09:58:06 INFO - "/builds/slave/test"] 09:58:06 INFO - --app=APP Application being installed. [default: firefox] 09:58:06 INFO - mkdir: /builds/slave/test/build/application 09:58:06 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'] 09:58:06 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 09:58:40 INFO - Reading from file tmpfile_stdout 09:58:40 INFO - Output received: 09:58:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:58:40 INFO - Running post-action listener: _resource_record_post_action 09:58:40 INFO - ##### 09:58:40 INFO - ##### Running run-tests step. 09:58:40 INFO - ##### 09:58:40 INFO - Running pre-action listener: _resource_record_pre_action 09:58:40 INFO - Running main action method: run_tests 09:58:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:58:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:58:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:58:40 INFO - 2016-03-11 09:58:40.567 screenresolution[1641:7488] starting screenresolution argv=screenresolution get 09:58:40 INFO - 2016-03-11 09:58:40.570 screenresolution[1641:7488] Display 0: 1600x1200x32@60 09:58:40 INFO - 2016-03-11 09:58:40.575 screenresolution[1642:7490] starting screenresolution argv=screenresolution list 09:58:40 INFO - Available Modes on Display 0 09:58:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:58:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:58:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:58:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:58:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:58:40 INFO - Intel Iris: 09:58:40 INFO - Chipset Model: Intel Iris 09:58:40 INFO - Type: GPU 09:58:40 INFO - Bus: Built-In 09:58:40 INFO - VRAM (Dynamic, Max): 1536 MB 09:58:40 INFO - Vendor: Intel (0x8086) 09:58:40 INFO - Device ID: 0x0a2e 09:58:40 INFO - Revision ID: 0x0009 09:58:40 INFO - Displays: 09:58:40 INFO - Display: 09:58:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:58:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:58:40 INFO - Display Serial Number: 1600x1200 60 09:58:40 INFO - Main Display: Yes 09:58:40 INFO - Mirror: Off 09:58:40 INFO - Online: Yes 09:58:40 INFO - Rotation: Supported 09:58:40 INFO - Return code: 0 09:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:40 INFO - Python 2.7.3 09:58:40 INFO - Return code: 0 09:58:40 INFO - grabbing minidump binary from tooltool 09:58:40 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')]} 09:58:40 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 0x104df5d30>, '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 0x104c19db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104decb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:40 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 09:58:40 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 09:58:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:40 INFO - Return code: 0 09:58:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:58:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:58:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:58:42 INFO - Return code: 0 09:58: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 09:58: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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 09:58:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gCNBkMhIda/Render', 09:58:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:42 INFO - 'HOME': '/Users/cltbld', 09:58:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:42 INFO - 'LOGNAME': 'cltbld', 09:58:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:42 INFO - 'MOZ_NO_REMOTE': '1', 09:58:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:42 INFO - 'NO_EM_RESTART': '1', 09:58:42 INFO - 'PAGER': '/bin/cat', 09:58:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:42 INFO - 'PWD': '/builds/slave/test', 09:58:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:42 INFO - 'SHELL': '/bin/bash', 09:58:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yEB4FcL6hM/Listeners', 09:58:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 09:58:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:42 INFO - 'USER': 'cltbld', 09:58:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:42 INFO - 'XPC_FLAGS': '0x0', 09:58:42 INFO - 'XPC_SERVICE_NAME': '0', 09:58:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58: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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 09:58:42 INFO - mozversion application_buildid: 20160311081313 09:58:42 INFO - mozversion application_changeset: 946ed22cad04431c75ab5093989dfedf1bae5a3e 09:58:42 INFO - mozversion application_display_name: Nightly 09:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:42 INFO - mozversion application_name: Firefox 09:58:42 INFO - mozversion application_remotingname: firefox 09:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:58:42 INFO - mozversion application_vendor: Mozilla 09:58:42 INFO - mozversion application_version: 48.0a1 09:58:42 INFO - mozversion platform_buildid: 20160311081313 09:58:42 INFO - mozversion platform_changeset: 946ed22cad04431c75ab5093989dfedf1bae5a3e 09:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:58:42 INFO - mozversion platform_version: 48.0a1 09:58:42 INFO - using testdate: 1457719122 09:58:42 INFO - actual date: 1457719122 09:58:42 INFO - starting webserver on 'localhost:49272' 09:58:42 INFO - SUITE-START | Running 2 tests 09:58:42 INFO - TEST-START | dromaeo_css 09:58:42 INFO - operating with platform_type : mac_ 09:58:42 INFO - Initialising browser for dromaeo_css test... 09:58:42 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpLGk2jH/profile http://localhost:49272/getInfo.html) 09:58:45 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:58:45 INFO - PROCESS | 1660 | colorDepth:24 09:58:45 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:58:45 INFO - PROCESS | 1660 | __metrics 09:58:45 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 09:58:46 INFO - TEST-INFO | 1660: exit 0 09:58:46 INFO - Browser initialized. 09:58:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:58:46 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpLGk2jH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:58:58 INFO - PROCESS | 1667 | RSS: Main: 255787008 09:58:58 INFO - PROCESS | 1667 | 09:59:48 INFO - PROCESS | 1667 | 1457719188131 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] 10:01:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 10:02:00 INFO - PROCESS | 1667 | RSS: Main: 268759040 10:02:00 INFO - PROCESS | 1667 | 10:05:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:05:03 INFO - PROCESS | 1667 | RSS: Main: 281849856 10:05:03 INFO - PROCESS | 1667 | 10:08:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:08:05 INFO - PROCESS | 1667 | RSS: Main: 281841664 10:08:05 INFO - PROCESS | 1667 | 10:11:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:11:07 INFO - PROCESS | 1667 | RSS: Main: 285028352 10:11:07 INFO - PROCESS | 1667 | 10:14:10 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:14:11 INFO - PROCESS | 1667 | RSS: Main: 287334400 10:14:11 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:17:13 INFO - PROCESS | 1667 | RSS: Main: 288620544 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | __start_tp_report 10:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 10:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 10:17:13 INFO - PROCESS | 1667 | |i|pagename|runs| 10:17:13 INFO - PROCESS | 1667 | |0;dojo.html;3510.9648903510974;3517.665821746934;3521.9647803521966;3558.4306510958254;3611.9638803611956;5772.797952071678;5805.622634528752;5832.358440571534;5878.294604647443;5907.556933230004;5705.629134106281;5856.560757943161;5864.648121112737;5939.4654481096695;6013.579049466539;5174.353205849269;5233.345831771028;5248.0815857225025;5254.264402983586;5345.091334473149;5287.656302340336;5297.311349524556;5332.68003919766;5335.626506144571;5348.91976620351;4436.489803672586;5201.8959620807755;5217.956408718272;5223.268742376071;5286.682799032032;5244.423113457517;5262.02652509287;5281.683099014033;5282.920756188661;5319.042572336978;5093.643444958854;5208.062548741225;5228.7908483660985;5256.8685782855355;5269.552088072518;4370.300751879716;5639.774409023634;5788.565857560658;5792.189093526909;5816.970915145397;6183.536234782409;6210.751569937197;6258.24901011877;6259.593126446766;6260.87478250437;6175.752969881244;6265.530085243579;6284.937150628481;6296;6335.493160547145;4990.82532111378;5820.039693450575;5991.101334799815;6006.189164462829;6018.488428483628;6371.936280637227;6394.968025159845;6406.903896441557;6408.807735767934;6409;6123.130109042722;6150.3849615039035;6219.284782250099;6226.813195604139;6264.404881536338;6092.72582733778;6116.031445914963;6239.251289845248;6250.968745156336;6262.405071518198;6208.658523781235;6232.407921247474;6275;6290.937090629035;6291.898917689386;6106.94607981953;6116.1836049259855;6213.316535181127;6266.843328916722;6270.435660790551;4985.850424487271;4988.077205716954;5001;5004.84985450437;5033.521815427529;4477.395551600493;4493.887652808706;4494.191045611756;4495.922961107902;4521.208788462071;5384.811531596375;5718.683933007139;5906.793262235801;5991.940080599138;6055.7274922628585;5003.724795136302;6267.5299352548745;6272.717727702265;6284.654344011032;6291.622502649856;5913.733881975321;5929.970350148308;5939.703014849327;5961.970190149022;5963.135345374983;5368.731563421891;5449.073657478239;5498.477644623755;5526.115821468546;5527.2538207341495;6431.967840160956;6434.131392262078;6479.449246814073;6480.967595161994;6483.61098334092;6112.290716697329;6284.780032698834;6304.590201636879;6316.842078948063;6319.96840015797;6396.456301214449;6445.8388540285;6450.129232553733;6471.741130354733;6491.221053473613;6194.752209911733;6251.9687401562705;6279.937200628118;6281.277653069956;6281.3404592518955;6174.8147555573405;6188.535859810622;6256.812295631138;6271.686415679289;6280.340564240872;5154.61340399464;6050;6109.283207920518;6170.228721409824;6219.968900155471;5332.280142180911;6179.104029915727;6214.844628884133;6258.061290806416;6270.655113968775;5309.778750887241;5711.600187986801;6069.817905462844;6096.055111457731;6139.171211886338;6122.855605810045;6172.4136207060255;6187.381261873777;6206.844828879314;6232.937670623236;6114.266288045463;6115.908261376172;6116.8776624468155;6136.6011209271255;6143.877122457615 10:17:13 INFO - PROCESS | 1667 | |1;ext.html;438.93415987601855;478.14173558462556;499.5479091422263;505.1286530734481;530.7054584705489;37778;37817.67638132666;37902;37929.62070379292;37997.620023799755;31073.06780796574;38255.04362390942;38609.613903860954;38789.22421551567;38817.61182388175;9369.43783372998;9606.663766768164;9615.855762163574;9636.903630963705;9641.758956026086;7948.960255198745;9517.095875891779;9557.665481708142;9613.086756758097;9684.322097453181;9599.04009599038;9651.034896510362;9663.371880827724;9692.951535242313;9720.416774993488;9577.904220957806;9616.374935629232;9660.71017869465;9667.613295468209;9691.321607487478;9565.091316324939;9682.46746428946;9696.466694331879;9709.029097090304;9774.51127443625;32010.039698809072;38554.807225963974;38882;38903;39101.608983910366;2879.452903948243;3159.794613350125;3239.1416274687226;3387.2209391840015;3389.3560223557447;27789.86105069482;28327.15018549447;28343.14970550887;28432.147035588965;28619.284517887012;2700.473407685502;2713.091114476653;2732.0437846753675;2902.8983985560403;2924.502834518137;255858.72070639528;316720;318814;320792;320926;45644;46804;63717.681411592646;64245.67877160678;64458.67770661117;38684.8065759675;43604.78197609055;45358.4124555639;45542.54457455383;45876;12904.548340808027;16164.62600678932;16232.75650865238;16243;16264.593385165228;12826.55107071248;12912.806307905388;12929.741405171844;12945.417456214493;12985.155964862253;14696.677299043138;14722.705545889023;14776.26118694061;15019.09885406879;15126.470573529874;6591.571547849375;6703.581173601401;6732.966335168391;6747.966260168766;6752.3922846944015;947.5641205045756;1034.2863424237253;1071.5231721883688;1081.3998230981724;1083.712816103733;28801.279968000967;29184;29466.705332946825;30017.24956876052;30076.548851767242;953.814006268771;1047.0785708576557;1106.7620461600795;1132.8640563132476;1239.9070069744625;14348;14415.78376324356;14539.27303634814;14552.49066282675;14878.70242595142;641463;652490;656708;658070;659226;58943;59262;59832.70083649554;59977.10034349488;60391;1436.1096120405416;1471.852814718541;1489.3670190169134;1489.5084622074905;1494.8131483564555;27402.45195096127;27770;27852.86073569619;28246.576301355908;28284;42464.30142794253;44387.8903027414;47896.281555776;47964.280535791295;48722.5127748718;416775;416911;419170;420228;421641;32557.511637325933;32816.34367312593;33375.33249334951;33390.666093338754;33512.66487335096;38956.61043389643;44327;45002.3249651262;45414.54585454103;46470.53529464662;36199.81900090483;37278.627213727515;37555;37604;37847.43228851514;36565.26869462649;36659.81670091739;36705;37210.6278937218;37438.6256137446;37013.814930925175;37100.25799484049;37227;38252.234955300184;38821;29297.41405171927;31577;32016.039518814472;32426.83786581052;33092.00723978285;24692.01231950702;24798.008079677333;25053.87473062623;25078.122265720613;25096.874515627303 10:17:13 INFO - PROCESS | 1667 | |2;jquery.html;319.3118828923669;350.9298140371926;357.8228776755506;363.3423503458739;370.5442305963666;18996.525086872818;19152.616947661056;20535;20585.48536286592;20586.69119963198;16592;20940.8952955235;21151.682724759103;21167.364979050613;21222.681659775117;5041.319421878036;5663.971680141603;5992.131140984555;6006.549508786837;6012.2184116064855;4195.098053918407;5429;5852;6437.742490300382;6476.708548115323;5024.849254522352;5415.918761218565;6377.42603165715;6381.680915954184;6389.456896163809;6064.423879731418;6262.780802671885;6285.528585356116;6324.3991820776955;6381.425671689523;4586.403767510235;5429.077056900336;5460.972695136499;5496.285482887239;5505.146702261156;24545.87727061371;24958.875205623855;24992.875035624704;25533.23400297994;25570.74429255702;2155.482684155807;2163.610550100981;2209.304069218191;2260.378395941113;2369.585322568561;14035.64910877226;14416.351264193032;14456.27718614065;14665.92667036658;15021.924890375478;1699.294792661044;1731.3247833345006;1736.9047441202576;1777.0759205213346;1783.7948635906907;89665;92123;92341.61487577691;92408.53795731046;93350.53324733333;8267.669293228204;10175.033371829664;10437.2693911427;10484;10502.002309780559;12334.629961101182;12496.25022498653;12567.811482827765;12632.557860475023;12663.936680316723;8496.192861678132;8505.65977360911;8598.441101328393;8606.053334133241;8681.30549556034;8871.600777965006;8890.288776897833;8958.731238062868;9047.547622618842;9049.77375565616;6073.848153796191;6166.5991710539565;6169.907451388232;6175.722092505848;6213.720382582795;1690.3069741405964;1756.2799252306747;1778.044151433413;1786.9463916082539;1820.044476649743;904;944.4805357053593;1024.1806554756165;1043.8173319669027;1087.124864484098;18673.719894201597;19129.756565823176;19534.70697939532;20210.494737631383;20231.595368092556;1004.5630150884389;1004.6182450668699;1008.1078245752415;1027.4605831938293;1067.6049861551276;9245.861312080324;11097.723761767338;11124.777504449865;11199.832002519968;11445.599404020819;647033;651228;658730.1190482146;660343;669763;99726;101261;101533;101574;104100;1055.0926203465015;1087.6410784441116;1089.1613457637575;1102.2559772153763;1106.5186643809968;17943.73084403761;18096.638067238317;18140.45578632643;18238.72641910399;18248.62277837294;44394;44413.77793111014;45182.77408612936;45914.77042614899;46780.53219467762;63865.361346385944;65333.34666653463;65639.34360656333;65916.68166636737;66010;6708.83227919306;7595.3164215220895;7790;7795.883061754192;7839.33365663925;12359.32023738703;12360.134790564574;12548.686282842637;12734.554290599785;12802.16785908913;10903.236773425784;11069.169812264274;11237.101031917591;11326.546938122383;11389.43052847371;9994.750656167978;10342;10431.009054139844;10502.4223667699;10618.8407173894;9890.406575605486;10294.279400441897;10875.07561857251;10954.726131846768;11153.219274650697;7472.439567032603;7808.258215469521;7927.405444591794;7958.641861116148;8194.83610327802;10490.370577765358;10869.076128529163;10884.61903833362;11188.937050980145;11202.83195752048 10:17:13 INFO - PROCESS | 1667 | |3;mootools.html;1562.2345050925046;1566.5222107257287;1878.9060546972657;2001.7597888253404;2010.3365889256547;6492.513061520382;8713.085126061767;8826.293896488281;9054.59254333555;9055.456672599632;8781;8858.981217160028;8925.375223734341;8952.328575356858;8963.686270980517;2499.175272160192;2505.5114252720728;2515.6478093066985;2517.4209931715623;2521.697396312436;2453.0678342229926;2511.8744062796877;2516.0816302049802;2516.5721827289403;2522.7225005249406;2479.504099180162;2494.0397946790436;2495.7629025242572;2499.5875680512695;2524.6591710119083;2475.393528585499;2503.6369726389753;2514.396544829246;2519.1308998395707;2528.292078218102;2462.5198086373166;2470.6788117544606;2503.7621425964503;2508.5359208546297;2522.8612426316545;8992.910070899272;8993.865092023625;9014.774630634287;9017;9066.456012639263;5426.9185962210595;5553.916691249635;5555.972220138873;5565;5566.805161819317;3589.28214357127;3682.4844521766972;3695.7043436525014;3727.422249551324;3734.10381508436;901.8286525560122;1019.306871327497;1044.6448207609374;1062.097217365241;1063.9360639360639;9480.620775168985;11502.424878756028;11628.244164129304;11640.476178571984;11647.41762911851;3895.5909629488497;4651.418572678415;4654.115718013567;4731.1720448921305;4786.928196077061;9221.216196623229;9236.399634023766;9303.116203960748;9306.2089722373;9346.57940392684;4381.364702118175;5280.815171469057;5310.60170487215;5346.224797404355;5482.91775623366;4438.178936896685;4861.7326047067045;4961.330220420269;4970.726610036482;4982.3522942018035;3955.7428767130045;4035.9506528302268;4038.45480860086;4066.268071747055;4075.083106301118;1326.5688651188402;1345.5357901523957;1351.743168797945;1356.4709763192363;1369.1921766158014;1331.2212355771787;1335.2255691698792;1365.242290528766;1373.6291201375573;1404.389090745529;8108.351331893435;8161.63272652732;8188.5496297703;8386.329093672492;8400.873986890201;1228.7051107734258;1236.6970092327438;1238.597455826842;1245.9003279737599;1256.1207154991544;6273.780417685451;6322.557420980579;6372.936270637234;6381.329960354189;6414.61512309263;10394.636187733393;10739.248252622398;10769.56921723138;10775.78448431027;10908.127349812155;10582.523786429476;10603.787924241473;10607.57569697219;10690.251682382159;10699.83950240747;8321.209485098905;8322.334213262924;8491;8494.83010339802;8594.87107693385;7777.338926191337;7943.165967573322;7955.204479551999;7999.720009799629;8004.279614834692;9390.812183756423;9580.18568421692;9607.423554586747;9615.663451779154;9777.608895644094;9722.75693107678;9997.650082247086;10019.998000199921;10027.147692446224;10125.645602404174;6380.234371875219;6967.303269672992;7048.400885924549;7077.82305442368;7175.103112110986;8230.794230144294;8233.711820086268;8265.297449716601;8293.751187464386;8402.159784021549;7304.306090921354;7392.889106663297;7424.70301187968;7500.737474188377;7559.584222867575;7251.021112150003;7286.016387787581;7317.524360916524;7344.522606030591;7442.106947166375;7699.076110866732;7759.224077592421;7760.961195193988;7767.456278060482;7779.805504862424;6922.653867306715;7024.227334993045;7048.330408611174;7048.400885924754;7077.681504332214;7152.105986751656;7195.604241766753;7235.746748863765;7243.45674074457;7276 10:17:13 INFO - PROCESS | 1667 | |4;prototype.html;298.80428319450755;326.29845831462353;327.3436759297608;331.6865213753536;337.9070755542226;6786.185657721074;6877.243503214642;6898.724051037965;6911.239763626009;6959.721611135555;6752.291009443999;6779.525433219676;6803.931960680392;6805.591664500133;6821.316489095882;4117.279476091687;4697.342372067913;4755.381800365947;4886.633502487328;4920.13897567926;4868.367112275399;4888.24232244001;4899.265110233458;4907.509249075099;4909.729964851932;4862.829800956967;4875.390576177978;4888.902221955559;4893.632977526682;4912.877178070541;4878.487758785347;4894.926576101361;4905.852824415273;4907.460179380265;4914.803407863681;4201.97899010503;4222.619964203236;4224;4235.682323825695;4242.172776308621;5679.943200568024;6089.786857459968;6147.2008638877105;6351.364863513658;6437.259715132726;5815.563832712522;5874.265716785402;5877.941220587825;5880.529557635379;5893.616914900518;7029.086218791575;7031.613261270628;7064.32888875556;7066.92933070673;7072.787816365517;4734.337192793012;4742.691725037862;4743.644226683013;4766.475687674353;4768.451628062782;7489.887651685229;7510.3616192623695;7520.623968801593;7523.3981281497345;7540.321371076575;3830.272248272875;4677.695949763254;4818.301346304836;4847.660663753574;4859.611231101503;4901.411830580353;4906.877328066756;4916.360873086547;4931.50684931504;4939.802407903716;5823.825285241365;5827.863566604557;5852.356240813507;5870.4716575507555;5899.262592175978;7134.215236324;7139.178994415709;7159.176694680074;7186.245444228385;7196.568205907663;1691.805442374118;1723.9482815515303;1727.8013028501882;1729.887557308796;1739.4086010756403;1074.1192222377576;1116.1573012375604;1116.9273997190319;1123.0902968595465;1140.6920131564598;6573.1783527059115;6649.767258145942;6671.366220209073;6680.331966803281;6690.765823196165;6129.295131059896;7403.889416587447;7456.440766942501;7473.327400533978;7489.737859174903;4530.592246697747;6012.609180403259;6340.714667839959;6718.664066796739;6767.35710107539;3140.952885706716;3970.344893092665;4000.9399859002137;4001.7598944063448;4002.7398219115667;7781.182975787574;7828.921710782934;7838.529688218725;7860.213978602094;7909.1299957004685;6279.686015699197;7553.962230188814;7772.494787838772;7775.533467991825;7779.299863012243;7818.218178182136;7830.373570114377;7845.137034926153;7854.960725196337;7879.803004924923;6551.918933376131;7142.357187853118;7520.962395187989;7540.736074237376;7559.962200188964;5942.61373010753;6011.368806275453;7396.445266605134;7410.5183163094225;7417.8145546361775;7078.327558881898;7631.590638713865;7670.693172273047;7813.218678132142;7831.216878312123;4882.2920676501;4913.459519452929;4931.48219436954;4933.038057578881;4938.456769755396;7551.848963020819;7554.206808285271;7564.773056808304;7568.394528437601;7587.58268295249;6368.395002474757;6809.557378770364;7285.235050319852;7319.8536029280185;7322.414206863332;7078.504504684829;7213.855722885408;7269.927300726925;7282.308180722823;7302.2697730226555;5462.535684466865;7063.1524217094275;7080.681369338289;7086.964565177141;7107.076080109553;7157.928420715726;7236.891446628199;7255.020572222894;7279.308465695751;7288.67200975968;7065.399441047569;7072.646367681698;7076.469264805057;7076.716931322895;7102.5028248022145 10:17:13 INFO - PROCESS | 1667 | |5;yui.html;647.2427260105676;652.0773106054935;677.1332694151484;733.7578599062308;766.2988365645434;14706.117632942018;14797.630059248524;15027.549173524785;15034.774478382806;15105.697886042273;11662.533498660065;13816.654583635414;13873.959453041038;13902.09636373635;13938.442462301497;753.9821241324223;920.8388532006906;935.5649622925339;935.6725146198844;937.292344280071;942.7454587261435;948.2887834124407;948.3551185194066;949.8290307744603;951.3198063384679;971.9368241064308;979.5494072726555;981.102291403365;981.362114625492;981.6858605246324;939.3659279985982;952.4618590496382;960.9087136722035;969.3747532841348;973.5813600151931;695.401954319285;715.5420530860254;722.1586851318208;725.1189804387694;728.5228175545027;15029.09825410468;15048.473303434437;15077.698446031018;15078.773818392732;15122.319495622613;12722.554710585086;12724.872751272462;12774.425150868234;12775.552855650008;12892.097553171281;8602.655893764242;9869.703908882744;10002.299839011272;10022.799544009078;10365.378077315385;3424.161080535285;3463.7767013973444;3481.8259087045544;3519.894403167909;3594.4069228577514;80628.19371806266;80785;80822.19177808205;80923;81476.59261703654;9232.399894006869;9402.576884040098;9468.053194680615;9639.759006024906;9824.45965471906;22086.558268834535;22089.889550552143;22104.668429973564;22114.004869780576;22127;7233.168185658611;7309.780706578811;7352;7596.392288617008;7691.423143264165;4060.634542891154;4095.406166105898;4124.237016152021;4133.937990930139;4159.916801664011;3610.6930910872343;3635.581908080552;3636.2363903580017;3643.3441980443777;3663.4871118043493;610.4140025575408;640.4044238857907;645.9870802583922;659.4032400677395;668.355037388922;572.1617829879247;580.0979476913355;581.4505292498633;593.9910901336483;601.2964831147568;7827.9608601956625;7996.520208787491;8048.718294859769;8108.554029528433;8278.875757274851;500.2845930319605;509.66362200947196;534.593708781329;590.8788698316835;604.4650484321407;3778.67881230093;3778.962210377916;3811.5807261201244;3817.522809648794;3820.84716611338;84373.89065273418;85264.72102918461;86088;86246.56876715577;94722;76536.1731913402;77676;78081.21918780853;79030;79090;67880.28478860889;68138.46115450807;68352.65823670849;68981.999999999;69059.3094069063;6911.412529935012;7751.961240193763;8362.498250105013;8386.916130838857;8677.435966662399;32936;46692.53307467018;49200;49285.50714492953;50027.74986125192;60807;62720;63247.05129423155;63406;63717.6814115945;10583.300576682806;10681.679549613524;10751.13990880712;10921.180911431515;11359.659210223706;11551.422428878355;11845.111616628616;11902.583409580624;12108.455119519467;12127.939360303142;11026.558937642725;11265.211435199457;11328.37693926809;11420.143489238175;11592;10919.727006824893;10953.83569246478;11234.494447749707;11370.260933039326;11486.712832179262;10678.145748339959;10931.125509959025;11224.270422422516;11329.433528323387;11356.318620882774;9320.673776417792;9492.667756628762;9532.61869525239;9908.455034973145;10109.494525273854;9347.906520934703;9458.952705236705;9508.191803696487;9537.284703647392;9633.614655413705 10:17:13 INFO - PROCESS | 1667 | __end_tp_report 10:17:13 INFO - PROCESS | 1667 | __start_cc_report 10:17:13 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,364 10:17:13 INFO - PROCESS | 1667 | __end_cc_report 10:17:13 INFO - PROCESS | 1667 | __startTimestamp1457720233835__endTimestamp 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | ------- Summary: start ------- 10:17:13 INFO - PROCESS | 1667 | Number of tests: 6 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5787.25 Median:6092.73 stddev:652.99 (10.7%) stddev-sans-first:630.10 10:17:13 INFO - PROCESS | 1667 | Values: 3511.0 3517.7 3522.0 3558.4 3612.0 5772.8 5805.6 5832.4 5878.3 5907.6 5705.6 5856.6 5864.6 5939.5 6013.6 5174.4 5233.3 5248.1 5254.3 5345.1 5287.7 5297.3 5332.7 5335.6 5348.9 4436.5 5201.9 5218.0 5223.3 5286.7 5244.4 5262.0 5281.7 5282.9 5319.0 5093.6 5208.1 5228.8 5256.9 5269.6 4370.3 5639.8 5788.6 5792.2 5817.0 6183.5 6210.8 6258.2 6259.6 6260.9 6175.8 6265.5 6284.9 6296.0 6335.5 4990.8 5820.0 5991.1 6006.2 6018.5 6371.9 6395.0 6406.9 6408.8 6409.0 6123.1 6150.4 6219.3 6226.8 6264.4 6092.7 6116.0 6239.3 6251.0 6262.4 6208.7 6232.4 6275.0 6290.9 6291.9 6106.9 6116.2 6213.3 6266.8 6270.4 4985.9 4988.1 5001.0 5004.8 5033.5 4477.4 4493.9 4494.2 4495.9 4521.2 5384.8 5718.7 5906.8 5991.9 6055.7 5003.7 6267.5 6272.7 6284.7 6291.6 5913.7 5930.0 5939.7 5962.0 5963.1 5368.7 5449.1 5498.5 5526.1 5527.3 6432.0 6434.1 6479.4 6481.0 6483.6 6112.3 6284.8 6304.6 6316.8 6320.0 6396.5 6445.8 6450.1 6471.7 6491.2 6194.8 6252.0 6279.9 6281.3 6281.3 6174.8 6188.5 6256.8 6271.7 6280.3 5154.6 6050.0 6109.3 6170.2 6220.0 5332.3 6179.1 6214.8 6258.1 6270.7 5309.8 5711.6 6069.8 6096.1 6139.2 6122.9 6172.4 6187.4 6206.8 6232.9 6114.3 6115.9 6116.9 6136.6 6143.9 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:59787.61 Median:37579.50 stddev:129090.50 (343.5%) stddev-sans-first:129375.73 10:17:13 INFO - PROCESS | 1667 | Values: 438.9 478.1 499.5 505.1 530.7 37778.0 37817.7 37902.0 37929.6 37997.6 31073.1 38255.0 38609.6 38789.2 38817.6 9369.4 9606.7 9615.9 9636.9 9641.8 7949.0 9517.1 9557.7 9613.1 9684.3 9599.0 9651.0 9663.4 9693.0 9720.4 9577.9 9616.4 9660.7 9667.6 9691.3 9565.1 9682.5 9696.5 9709.0 9774.5 32010.0 38554.8 38882.0 38903.0 39101.6 2879.5 3159.8 3239.1 3387.2 3389.4 27789.9 28327.2 28343.1 28432.1 28619.3 2700.5 2713.1 2732.0 2902.9 2924.5 255858.7 316720.0 318814.0 320792.0 320926.0 45644.0 46804.0 63717.7 64245.7 64458.7 38684.8 43604.8 45358.4 45542.5 45876.0 12904.5 16164.6 16232.8 16243.0 16264.6 12826.6 12912.8 12929.7 12945.4 12985.2 14696.7 14722.7 14776.3 15019.1 15126.5 6591.6 6703.6 6733.0 6748.0 6752.4 947.6 1034.3 1071.5 1081.4 1083.7 28801.3 29184.0 29466.7 30017.2 30076.5 953.8 1047.1 1106.8 1132.9 1239.9 14348.0 14415.8 14539.3 14552.5 14878.7 641463.0 652490.0 656708.0 658070.0 659226.0 58943.0 59262.0 59832.7 59977.1 60391.0 1436.1 1471.9 1489.4 1489.5 1494.8 27402.5 27770.0 27852.9 28246.6 28284.0 42464.3 44387.9 47896.3 47964.3 48722.5 416775.0 416911.0 419170.0 420228.0 421641.0 32557.5 32816.3 33375.3 33390.7 33512.7 38956.6 44327.0 45002.3 45414.5 46470.5 36199.8 37278.6 37555.0 37604.0 37847.4 36565.3 36659.8 36705.0 37210.6 37438.6 37013.8 37100.3 37227.0 38252.2 38821.0 29297.4 31577.0 32016.0 32426.8 33092.0 24692.0 24798.0 25053.9 25078.1 25096.9 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:34596.84 Median:2234.84 stddev:108075.09 (4835.9%) stddev-sans-first:108347.62 10:17:13 INFO - PROCESS | 1667 | Values: 319.3 350.9 357.8 363.3 370.5 18996.5 19152.6 20535.0 20585.5 20586.7 16592.0 20940.9 21151.7 21167.4 21222.7 5041.3 5664.0 5992.1 6006.5 6012.2 4195.1 5429.0 5852.0 6437.7 6476.7 5024.8 5415.9 6377.4 6381.7 6389.5 6064.4 6262.8 6285.5 6324.4 6381.4 4586.4 5429.1 5461.0 5496.3 5505.1 24545.9 24958.9 24992.9 25533.2 25570.7 2155.5 2163.6 2209.3 2260.4 2369.6 14035.6 14416.4 14456.3 14665.9 15021.9 1699.3 1731.3 1736.9 1777.1 1783.8 89665.0 92123.0 92341.6 92408.5 93350.5 8267.7 10175.0 10437.3 10484.0 10502.0 12334.6 12496.3 12567.8 12632.6 12663.9 8496.2 8505.7 8598.4 8606.1 8681.3 8871.6 8890.3 8958.7 9047.5 9049.8 6073.8 6166.6 6169.9 6175.7 6213.7 1690.3 1756.3 1778.0 1786.9 1820.0 904.0 944.5 1024.2 1043.8 1087.1 18673.7 19129.8 19534.7 20210.5 20231.6 1004.6 1004.6 1008.1 1027.5 1067.6 9245.9 11097.7 11124.8 11199.8 11445.6 647033.0 651228.0 658730.1 660343.0 669763.0 99726.0 101261.0 101533.0 101574.0 104100.0 1055.1 1087.6 1089.2 1102.3 1106.5 17943.7 18096.6 18140.5 18238.7 18248.6 44394.0 44413.8 45182.8 45914.8 46780.5 63865.4 65333.3 65639.3 65916.7 66010.0 6708.8 7595.3 7790.0 7795.9 7839.3 12359.3 12360.1 12548.7 12734.6 12802.2 10903.2 11069.2 11237.1 11326.5 11389.4 9994.8 10342.0 10431.0 10502.4 10618.8 9890.4 10294.3 10875.1 10954.7 11153.2 7472.4 7808.3 7927.4 7958.6 8194.8 10490.4 10869.1 10884.6 11188.9 11202.8 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6049.58 Median:5454.92 stddev:3122.43 (57.2%) stddev-sans-first:3112.97 10:17:13 INFO - PROCESS | 1667 | Values: 1562.2 1566.5 1878.9 2001.8 2010.3 6492.5 8713.1 8826.3 9054.6 9055.5 8781.0 8859.0 8925.4 8952.3 8963.7 2499.2 2505.5 2515.6 2517.4 2521.7 2453.1 2511.9 2516.1 2516.6 2522.7 2479.5 2494.0 2495.8 2499.6 2524.7 2475.4 2503.6 2514.4 2519.1 2528.3 2462.5 2470.7 2503.8 2508.5 2522.9 8992.9 8993.9 9014.8 9017.0 9066.5 5426.9 5553.9 5556.0 5565.0 5566.8 3589.3 3682.5 3695.7 3727.4 3734.1 901.8 1019.3 1044.6 1062.1 1063.9 9480.6 11502.4 11628.2 11640.5 11647.4 3895.6 4651.4 4654.1 4731.2 4786.9 9221.2 9236.4 9303.1 9306.2 9346.6 4381.4 5280.8 5310.6 5346.2 5482.9 4438.2 4861.7 4961.3 4970.7 4982.4 3955.7 4036.0 4038.5 4066.3 4075.1 1326.6 1345.5 1351.7 1356.5 1369.2 1331.2 1335.2 1365.2 1373.6 1404.4 8108.4 8161.6 8188.5 8386.3 8400.9 1228.7 1236.7 1238.6 1245.9 1256.1 6273.8 6322.6 6372.9 6381.3 6414.6 10394.6 10739.2 10769.6 10775.8 10908.1 10582.5 10603.8 10607.6 10690.3 10699.8 8321.2 8322.3 8491.0 8494.8 8594.9 7777.3 7943.2 7955.2 7999.7 8004.3 9390.8 9580.2 9607.4 9615.7 9777.6 9722.8 9997.7 10020.0 10027.1 10125.6 6380.2 6967.3 7048.4 7077.8 7175.1 8230.8 8233.7 8265.3 8293.8 8402.2 7304.3 7392.9 7424.7 7500.7 7559.6 7251.0 7286.0 7317.5 7344.5 7442.1 7699.1 7759.2 7761.0 7767.5 7779.8 6922.7 7024.2 7048.3 7048.4 7077.7 7152.1 7195.6 7235.7 7243.5 7276.0 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5852.26 Median:6611.47 stddev:1875.08 (28.4%) stddev-sans-first:1833.42 10:17:13 INFO - PROCESS | 1667 | Values: 298.8 326.3 327.3 331.7 337.9 6786.2 6877.2 6898.7 6911.2 6959.7 6752.3 6779.5 6803.9 6805.6 6821.3 4117.3 4697.3 4755.4 4886.6 4920.1 4868.4 4888.2 4899.3 4907.5 4909.7 4862.8 4875.4 4888.9 4893.6 4912.9 4878.5 4894.9 4905.9 4907.5 4914.8 4202.0 4222.6 4224.0 4235.7 4242.2 5679.9 6089.8 6147.2 6351.4 6437.3 5815.6 5874.3 5877.9 5880.5 5893.6 7029.1 7031.6 7064.3 7066.9 7072.8 4734.3 4742.7 4743.6 4766.5 4768.5 7489.9 7510.4 7520.6 7523.4 7540.3 3830.3 4677.7 4818.3 4847.7 4859.6 4901.4 4906.9 4916.4 4931.5 4939.8 5823.8 5827.9 5852.4 5870.5 5899.3 7134.2 7139.2 7159.2 7186.2 7196.6 1691.8 1723.9 1727.8 1729.9 1739.4 1074.1 1116.2 1116.9 1123.1 1140.7 6573.2 6649.8 6671.4 6680.3 6690.8 6129.3 7403.9 7456.4 7473.3 7489.7 4530.6 6012.6 6340.7 6718.7 6767.4 3141.0 3970.3 4000.9 4001.8 4002.7 7781.2 7828.9 7838.5 7860.2 7909.1 6279.7 7554.0 7772.5 7775.5 7779.3 7818.2 7830.4 7845.1 7855.0 7879.8 6551.9 7142.4 7521.0 7540.7 7560.0 5942.6 6011.4 7396.4 7410.5 7417.8 7078.3 7631.6 7670.7 7813.2 7831.2 4882.3 4913.5 4931.5 4933.0 4938.5 7551.8 7554.2 7564.8 7568.4 7587.6 6368.4 6809.6 7285.2 7319.9 7322.4 7078.5 7213.9 7269.9 7282.3 7302.3 5462.5 7063.2 7080.7 7087.0 7107.1 7157.9 7236.9 7255.0 7279.3 7288.7 7065.4 7072.6 7076.5 7076.7 7102.5 10:17:13 INFO - PROCESS | 1667 | 10:17:13 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17831.77 Median:31665.21 stddev:24866.19 (78.5%) stddev-sans-first:24902.47 10:17:13 INFO - PROCESS | 1667 | Values: 647.2 652.1 677.1 733.8 766.3 14706.1 14797.6 15027.5 15034.8 15105.7 11662.5 13816.7 13874.0 13902.1 13938.4 754.0 920.8 935.6 935.7 937.3 942.7 948.3 948.4 949.8 951.3 971.9 979.5 981.1 981.4 981.7 939.4 952.5 960.9 969.4 973.6 695.4 715.5 722.2 725.1 728.5 15029.1 15048.5 15077.7 15078.8 15122.3 12722.6 12724.9 12774.4 12775.6 12892.1 8602.7 9869.7 10002.3 10022.8 10365.4 3424.2 3463.8 3481.8 3519.9 3594.4 80628.2 80785.0 80822.2 80923.0 81476.6 9232.4 9402.6 9468.1 9639.8 9824.5 22086.6 22089.9 22104.7 22114.0 22127.0 7233.2 7309.8 7352.0 7596.4 7691.4 4060.6 4095.4 4124.2 4133.9 4159.9 3610.7 3635.6 3636.2 3643.3 3663.5 610.4 640.4 646.0 659.4 668.4 572.2 580.1 581.5 594.0 601.3 7828.0 7996.5 8048.7 8108.6 8278.9 500.3 509.7 534.6 590.9 604.5 3778.7 3779.0 3811.6 3817.5 3820.8 84373.9 85264.7 86088.0 86246.6 94722.0 76536.2 77676.0 78081.2 79030.0 79090.0 67880.3 68138.5 68352.7 68982.0 69059.3 6911.4 7752.0 8362.5 8386.9 8677.4 32936.0 46692.5 49200.0 49285.5 50027.7 60807.0 62720.0 63247.1 63406.0 63717.7 10583.3 10681.7 10751.1 10921.2 11359.7 11551.4 11845.1 11902.6 12108.5 12127.9 11026.6 11265.2 11328.4 11420.1 11592.0 10919.7 10953.8 11234.5 11370.3 11486.7 10678.1 10931.1 11224.3 11329.4 11356.3 9320.7 9492.7 9532.6 9908.5 10109.5 9347.9 9459.0 9508.2 9537.3 9633.6 10:17:13 INFO - PROCESS | 1667 | -------- Summary: end -------- 10:17:13 INFO - PROCESS | 1667 | 10:17:14 INFO - TEST-INFO | 1667: exit 0 10:17:14 INFO - TEST-OK | dromaeo_css | took 1112016ms 10:17:14 INFO - TEST-START | kraken 10:17:14 INFO - operating with platform_type : mac_ 10:17:14 INFO - Initialising browser for kraken test... 10:17:14 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpQcV9uJ/profile http://localhost:49272/getInfo.html) 10:17:17 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 10:17:17 INFO - PROCESS | 1675 | colorDepth:24 10:17:17 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 10:17:17 INFO - PROCESS | 1675 | __metrics 10:17:17 ERROR - PROCESS | 1675 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2851: TypeError: this.tabs is undefined 10:17:18 INFO - TEST-INFO | 1675: exit 0 10:17:18 INFO - Browser initialized. 10:17:18 INFO - Running cycle 1/1 for kraken test... 10:17:18 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpQcV9uJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:30 INFO - PROCESS | 1678 | RSS: Main: 257257472 10:17:30 INFO - PROCESS | 1678 | 10:17:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:33 INFO - PROCESS | 1678 | RSS: Main: 269615104 10:17:33 INFO - PROCESS | 1678 | 10:17:35 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:17:36 INFO - PROCESS | 1678 | RSS: Main: 277454848 10:17:36 INFO - PROCESS | 1678 | 10:17:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:17:40 INFO - PROCESS | 1678 | RSS: Main: 281665536 10:17:40 INFO - PROCESS | 1678 | 10:17:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:17:42 INFO - PROCESS | 1678 | RSS: Main: 281985024 10:17:42 INFO - PROCESS | 1678 | 10:17:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:17:45 INFO - PROCESS | 1678 | RSS: Main: 282476544 10:17:45 INFO - PROCESS | 1678 | 10:17:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:17:49 INFO - PROCESS | 1678 | RSS: Main: 283578368 10:17:49 INFO - PROCESS | 1678 | 10:17:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:52 INFO - PROCESS | 1678 | RSS: Main: 284213248 10:17:52 INFO - PROCESS | 1678 | 10:17:55 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:17:56 INFO - PROCESS | 1678 | RSS: Main: 283643904 10:17:56 INFO - PROCESS | 1678 | 10:17:58 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:58 INFO - PROCESS | 1678 | RSS: Main: 282484736 10:17:58 INFO - PROCESS | 1678 | 10:18:00 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:01 INFO - PROCESS | 1678 | RSS: Main: 283201536 10:18:01 INFO - PROCESS | 1678 | 10:18:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:03 INFO - PROCESS | 1678 | RSS: Main: 283000832 10:18:03 INFO - PROCESS | 1678 | 10:18:06 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:07 INFO - PROCESS | 1678 | RSS: Main: 283881472 10:18:07 INFO - PROCESS | 1678 | 10:18:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:10 INFO - PROCESS | 1678 | RSS: Main: 283996160 10:18:10 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:18:12 INFO - PROCESS | 1678 | RSS: Main: 285999104 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | __start_tp_report 10:18:12 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 10:18:12 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 10:18:12 INFO - PROCESS | 1678 | |i|pagename|runs| 10:18:12 INFO - PROCESS | 1678 | |0;ai-astar;115;110;116;115;114;127;116;115;117;115 10:18:12 INFO - PROCESS | 1678 | |1;audio-beat-detection;151;123;144;159;117;141;142;120;163;120 10:18:12 INFO - PROCESS | 1678 | |2;audio-dft;190;198;195;202;193;262;254;196;200;204 10:18:12 INFO - PROCESS | 1678 | |3;audio-fft;77;69;55;56;52;69;93;130;73;78 10:18:12 INFO - PROCESS | 1678 | |4;audio-oscillator;79;87;120;79;83;82;121;79;80;120 10:18:12 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;89;88;90;77;137;86;96;130;90;106 10:18:12 INFO - PROCESS | 1678 | |6;imaging-darkroom;94;96;96;132;112;99;91;151;90;107 10:18:12 INFO - PROCESS | 1678 | |7;imaging-desaturate;89;123;91;145;119;91;99;92;108;151 10:18:12 INFO - PROCESS | 1678 | |8;json-parse-financial;57;58;67;83;87;74;55;64;58;56 10:18:12 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;65;65;68;65;72;100;109;99;78;67 10:18:12 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;85;84;85;86;85;87;86;87;85;85 10:18:12 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;148;115;140;141;113;144;136;135;135;152 10:18:12 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;130;142;138;145;143;145;144;142;150;139 10:18:12 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;71;71;66;70;70;70;70;69;69;68 10:18:12 INFO - PROCESS | 1678 | __end_tp_report 10:18:12 INFO - PROCESS | 1678 | __start_cc_report 10:18:12 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,945 10:18:12 INFO - PROCESS | 1678 | __end_cc_report 10:18:12 INFO - PROCESS | 1678 | __startTimestamp1457720292299__endTimestamp 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | ------- Summary: start ------- 10:18:12 INFO - PROCESS | 1678 | Number of tests: 14 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:116.00 Median:115.50 stddev:4.29 (3.7%) stddev-sans-first:4.54 10:18:12 INFO - PROCESS | 1678 | Values: 115.0 110.0 116.0 115.0 114.0 127.0 116.0 115.0 117.0 115.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:143.00 stddev:17.03 (11.9%) stddev-sans-first:17.40 10:18:12 INFO - PROCESS | 1678 | Values: 151.0 123.0 144.0 159.0 117.0 141.0 142.0 120.0 163.0 120.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:209.40 Median:201.00 stddev:26.01 (12.9%) stddev-sans-first:26.63 10:18:12 INFO - PROCESS | 1678 | Values: 190.0 198.0 195.0 202.0 193.0 262.0 254.0 196.0 200.0 204.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:75.20 Median:71.00 stddev:22.92 (32.3%) stddev-sans-first:24.30 10:18:12 INFO - PROCESS | 1678 | Values: 77.0 69.0 55.0 56.0 52.0 69.0 93.0 130.0 73.0 78.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:79.50 stddev:19.02 (23.9%) stddev-sans-first:19.49 10:18:12 INFO - PROCESS | 1678 | Values: 79.0 87.0 120.0 79.0 83.0 82.0 121.0 79.0 80.0 120.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:98.90 Median:88.50 stddev:19.72 (22.3%) stddev-sans-first:20.59 10:18:12 INFO - PROCESS | 1678 | Values: 89.0 88.0 90.0 77.0 137.0 86.0 96.0 130.0 90.0 106.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:92.50 stddev:20.02 (21.6%) stddev-sans-first:20.69 10:18:12 INFO - PROCESS | 1678 | Values: 94.0 96.0 96.0 132.0 112.0 99.0 91.0 151.0 90.0 107.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:90.00 stddev:23.00 (25.6%) stddev-sans-first:23.00 10:18:12 INFO - PROCESS | 1678 | Values: 89.0 123.0 91.0 145.0 119.0 91.0 99.0 92.0 108.0 151.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.50 stddev:11.69 (17.8%) stddev-sans-first:11.94 10:18:12 INFO - PROCESS | 1678 | Values: 57.0 58.0 67.0 83.0 87.0 74.0 55.0 64.0 58.0 56.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:67.50 stddev:17.14 (25.4%) stddev-sans-first:17.44 10:18:12 INFO - PROCESS | 1678 | Values: 65.0 65.0 68.0 65.0 72.0 100.0 109.0 99.0 78.0 67.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:0.97 (1.1%) stddev-sans-first:1.01 10:18:12 INFO - PROCESS | 1678 | Values: 85.0 84.0 85.0 86.0 85.0 87.0 86.0 87.0 85.0 85.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:140.50 stddev:12.81 (9.1%) stddev-sans-first:12.82 10:18:12 INFO - PROCESS | 1678 | Values: 148.0 115.0 140.0 141.0 113.0 144.0 136.0 135.0 135.0 152.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:143.50 stddev:5.33 (3.7%) stddev-sans-first:3.55 10:18:12 INFO - PROCESS | 1678 | Values: 130.0 142.0 138.0 145.0 143.0 145.0 144.0 142.0 150.0 139.0 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.51 (2.2%) stddev-sans-first:1.48 10:18:12 INFO - PROCESS | 1678 | Values: 71.0 71.0 66.0 70.0 70.0 70.0 70.0 69.0 69.0 68.0 10:18:12 INFO - PROCESS | 1678 | -------- Summary: end -------- 10:18:12 INFO - PROCESS | 1678 | 10:18:12 INFO - TEST-INFO | 1678: exit 0 10:18:13 INFO - TEST-OK | kraken | took 58705ms 10:18:13 INFO - SUITE-END | took 1170s 10:18:13 INFO - Completed test suite (00:19:31) 10:18:13 INFO - javascript benchmark 10:18:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3510.9648903510974, 3517.665821746934, 3521.9647803521966, 3558.4306510958254, 3611.9638803611956, 5772.797952071678, 5805.622634528752, 5832.358440571534, 5878.294604647443, 5907.556933230004, 5705.629134106281, 5856.560757943161, 5864.648121112737, 5939.4654481096695, 6013.579049466539, 5174.353205849269, 5233.345831771028, 5248.0815857225025, 5254.264402983586, 5345.091334473149, 5287.656302340336, 5297.311349524556, 5332.68003919766, 5335.626506144571, 5348.91976620351, 4436.489803672586, 5201.8959620807755, 5217.956408718272, 5223.268742376071, 5286.682799032032, 5244.423113457517, 5262.02652509287, 5281.683099014033, 5282.920756188661, 5319.042572336978, 5093.643444958854, 5208.062548741225, 5228.7908483660985, 5256.8685782855355, 5269.552088072518, 4370.300751879716, 5639.774409023634, 5788.565857560658, 5792.189093526909, 5816.970915145397, 6183.536234782409, 6210.751569937197, 6258.24901011877, 6259.593126446766, 6260.87478250437, 6175.752969881244, 6265.530085243579, 6284.937150628481, 6296.0, 6335.493160547145, 4990.82532111378, 5820.039693450575, 5991.101334799815, 6006.189164462829, 6018.488428483628, 6371.936280637227, 6394.968025159845, 6406.903896441557, 6408.807735767934, 6409.0, 6123.130109042722, 6150.3849615039035, 6219.284782250099, 6226.813195604139, 6264.404881536338, 6092.72582733778, 6116.031445914963, 6239.251289845248, 6250.968745156336, 6262.405071518198, 6208.658523781235, 6232.407921247474, 6275.0, 6290.937090629035, 6291.898917689386, 6106.94607981953, 6116.1836049259855, 6213.316535181127, 6266.843328916722, 6270.435660790551, 4985.850424487271, 4988.077205716954, 5001.0, 5004.84985450437, 5033.521815427529, 4477.395551600493, 4493.887652808706, 4494.191045611756, 4495.922961107902, 4521.208788462071, 5384.811531596375, 5718.683933007139, 5906.793262235801, 5991.940080599138, 6055.7274922628585, 5003.724795136302, 6267.5299352548745, 6272.717727702265, 6284.654344011032, 6291.622502649856, 5913.733881975321, 5929.970350148308, 5939.703014849327, 5961.970190149022, 5963.135345374983, 5368.731563421891, 5449.073657478239, 5498.477644623755, 5526.115821468546, 5527.2538207341495, 6431.967840160956, 6434.131392262078, 6479.449246814073, 6480.967595161994, 6483.61098334092, 6112.290716697329, 6284.780032698834, 6304.590201636879, 6316.842078948063, 6319.96840015797, 6396.456301214449, 6445.8388540285, 6450.129232553733, 6471.741130354733, 6491.221053473613, 6194.752209911733, 6251.9687401562705, 6279.937200628118, 6281.277653069956, 6281.3404592518955, 6174.8147555573405, 6188.535859810622, 6256.812295631138, 6271.686415679289, 6280.340564240872, 5154.61340399464, 6050.0, 6109.283207920518, 6170.228721409824, 6219.968900155471, 5332.280142180911, 6179.104029915727, 6214.844628884133, 6258.061290806416, 6270.655113968775, 5309.778750887241, 5711.600187986801, 6069.817905462844, 6096.055111457731, 6139.171211886338, 6122.855605810045, 6172.4136207060255, 6187.381261873777, 6206.844828879314, 6232.937670623236, 6114.266288045463, 6115.908261376172, 6116.8776624468155, 6136.6011209271255, 6143.877122457615], "unit": "score", "name": "dojo.html", "value": 5748.649294138277}, {"lowerIsBetter": false, "replicates": [438.93415987601855, 478.14173558462556, 499.5479091422263, 505.1286530734481, 530.7054584705489, 37778.0, 37817.67638132666, 37902.0, 37929.62070379292, 37997.620023799755, 31073.06780796574, 38255.04362390942, 38609.613903860954, 38789.22421551567, 38817.61182388175, 9369.43783372998, 9606.663766768164, 9615.855762163574, 9636.903630963705, 9641.758956026086, 7948.960255198745, 9517.095875891779, 9557.665481708142, 9613.086756758097, 9684.322097453181, 9599.04009599038, 9651.034896510362, 9663.371880827724, 9692.951535242313, 9720.416774993488, 9577.904220957806, 9616.374935629232, 9660.71017869465, 9667.613295468209, 9691.321607487478, 9565.091316324939, 9682.46746428946, 9696.466694331879, 9709.029097090304, 9774.51127443625, 32010.039698809072, 38554.807225963974, 38882.0, 38903.0, 39101.608983910366, 2879.452903948243, 3159.794613350125, 3239.1416274687226, 3387.2209391840015, 3389.3560223557447, 27789.86105069482, 28327.15018549447, 28343.14970550887, 28432.147035588965, 28619.284517887012, 2700.473407685502, 2713.091114476653, 2732.0437846753675, 2902.8983985560403, 2924.502834518137, 255858.72070639528, 316720.0, 318814.0, 320792.0, 320926.0, 45644.0, 46804.0, 63717.681411592646, 64245.67877160678, 64458.67770661117, 38684.8065759675, 43604.78197609055, 45358.4124555639, 45542.54457455383, 45876.0, 12904.548340808027, 16164.62600678932, 16232.75650865238, 16243.0, 16264.593385165228, 12826.55107071248, 12912.806307905388, 12929.741405171844, 12945.417456214493, 12985.155964862253, 14696.677299043138, 14722.705545889023, 14776.26118694061, 15019.09885406879, 15126.470573529874, 6591.571547849375, 6703.581173601401, 6732.966335168391, 6747.966260168766, 6752.3922846944015, 947.5641205045756, 1034.2863424237253, 1071.5231721883688, 1081.3998230981724, 1083.712816103733, 28801.279968000967, 29184.0, 29466.705332946825, 30017.24956876052, 30076.548851767242, 953.814006268771, 1047.0785708576557, 1106.7620461600795, 1132.8640563132476, 1239.9070069744625, 14348.0, 14415.78376324356, 14539.27303634814, 14552.49066282675, 14878.70242595142, 641463.0, 652490.0, 656708.0, 658070.0, 659226.0, 58943.0, 59262.0, 59832.70083649554, 59977.10034349488, 60391.0, 1436.1096120405416, 1471.852814718541, 1489.3670190169134, 1489.5084622074905, 1494.8131483564555, 27402.45195096127, 27770.0, 27852.86073569619, 28246.576301355908, 28284.0, 42464.30142794253, 44387.8903027414, 47896.281555776, 47964.280535791295, 48722.5127748718, 416775.0, 416911.0, 419170.0, 420228.0, 421641.0, 32557.511637325933, 32816.34367312593, 33375.33249334951, 33390.666093338754, 33512.66487335096, 38956.61043389643, 44327.0, 45002.3249651262, 45414.54585454103, 46470.53529464662, 36199.81900090483, 37278.627213727515, 37555.0, 37604.0, 37847.43228851514, 36565.26869462649, 36659.81670091739, 36705.0, 37210.6278937218, 37438.6256137446, 37013.814930925175, 37100.25799484049, 37227.0, 38252.234955300184, 38821.0, 29297.41405171927, 31577.0, 32016.039518814472, 32426.83786581052, 33092.00723978285, 24692.01231950702, 24798.008079677333, 25053.87473062623, 25078.122265720613, 25096.874515627303], "unit": "score", "name": "ext.html", "value": 18800.860464414105}, {"lowerIsBetter": false, "replicates": [319.3118828923669, 350.9298140371926, 357.8228776755506, 363.3423503458739, 370.5442305963666, 18996.525086872818, 19152.616947661056, 20535.0, 20585.48536286592, 20586.69119963198, 16592.0, 20940.8952955235, 21151.682724759103, 21167.364979050613, 21222.681659775117, 5041.319421878036, 5663.971680141603, 5992.131140984555, 6006.549508786837, 6012.2184116064855, 4195.098053918407, 5429.0, 5852.0, 6437.742490300382, 6476.708548115323, 5024.849254522352, 5415.918761218565, 6377.42603165715, 6381.680915954184, 6389.456896163809, 6064.423879731418, 6262.780802671885, 6285.528585356116, 6324.3991820776955, 6381.425671689523, 4586.403767510235, 5429.077056900336, 5460.972695136499, 5496.285482887239, 5505.146702261156, 24545.87727061371, 24958.875205623855, 24992.875035624704, 25533.23400297994, 25570.74429255702, 2155.482684155807, 2163.610550100981, 2209.304069218191, 2260.378395941113, 2369.585322568561, 14035.64910877226, 14416.351264193032, 14456.27718614065, 14665.92667036658, 15021.924890375478, 1699.294792661044, 1731.3247833345006, 1736.9047441202576, 1777.0759205213346, 1783.7948635906907, 89665.0, 92123.0, 92341.61487577691, 92408.53795731046, 93350.53324733333, 8267.669293228204, 10175.033371829664, 10437.2693911427, 10484.0, 10502.002309780559, 12334.629961101182, 12496.25022498653, 12567.811482827765, 12632.557860475023, 12663.936680316723, 8496.192861678132, 8505.65977360911, 8598.441101328393, 8606.053334133241, 8681.30549556034, 8871.600777965006, 8890.288776897833, 8958.731238062868, 9047.547622618842, 9049.77375565616, 6073.848153796191, 6166.5991710539565, 6169.907451388232, 6175.722092505848, 6213.720382582795, 1690.3069741405964, 1756.2799252306747, 1778.044151433413, 1786.9463916082539, 1820.044476649743, 904.0, 944.4805357053593, 1024.1806554756165, 1043.8173319669027, 1087.124864484098, 18673.719894201597, 19129.756565823176, 19534.70697939532, 20210.494737631383, 20231.595368092556, 1004.5630150884389, 1004.6182450668699, 1008.1078245752415, 1027.4605831938293, 1067.6049861551276, 9245.861312080324, 11097.723761767338, 11124.777504449865, 11199.832002519968, 11445.599404020819, 647033.0, 651228.0, 658730.1190482146, 660343.0, 669763.0, 99726.0, 101261.0, 101533.0, 101574.0, 104100.0, 1055.0926203465015, 1087.6410784441116, 1089.1613457637575, 1102.2559772153763, 1106.5186643809968, 17943.73084403761, 18096.638067238317, 18140.45578632643, 18238.72641910399, 18248.62277837294, 44394.0, 44413.77793111014, 45182.77408612936, 45914.77042614899, 46780.53219467762, 63865.361346385944, 65333.34666653463, 65639.34360656333, 65916.68166636737, 66010.0, 6708.83227919306, 7595.3164215220895, 7790.0, 7795.883061754192, 7839.33365663925, 12359.32023738703, 12360.134790564574, 12548.686282842637, 12734.554290599785, 12802.16785908913, 10903.236773425784, 11069.169812264274, 11237.101031917591, 11326.546938122383, 11389.43052847371, 9994.750656167978, 10342.0, 10431.009054139844, 10502.4223667699, 10618.8407173894, 9890.406575605486, 10294.279400441897, 10875.07561857251, 10954.726131846768, 11153.219274650697, 7472.439567032603, 7808.258215469521, 7927.405444591794, 7958.641861116148, 8194.83610327802, 10490.370577765358, 10869.076128529163, 10884.61903833362, 11188.937050980145, 11202.83195752048], "unit": "score", "name": "jquery.html", "value": 9397.231018765046}, {"lowerIsBetter": false, "replicates": [1562.2345050925046, 1566.5222107257287, 1878.9060546972657, 2001.7597888253404, 2010.3365889256547, 6492.513061520382, 8713.085126061767, 8826.293896488281, 9054.59254333555, 9055.456672599632, 8781.0, 8858.981217160028, 8925.375223734341, 8952.328575356858, 8963.686270980517, 2499.175272160192, 2505.5114252720728, 2515.6478093066985, 2517.4209931715623, 2521.697396312436, 2453.0678342229926, 2511.8744062796877, 2516.0816302049802, 2516.5721827289403, 2522.7225005249406, 2479.504099180162, 2494.0397946790436, 2495.7629025242572, 2499.5875680512695, 2524.6591710119083, 2475.393528585499, 2503.6369726389753, 2514.396544829246, 2519.1308998395707, 2528.292078218102, 2462.5198086373166, 2470.6788117544606, 2503.7621425964503, 2508.5359208546297, 2522.8612426316545, 8992.910070899272, 8993.865092023625, 9014.774630634287, 9017.0, 9066.456012639263, 5426.9185962210595, 5553.916691249635, 5555.972220138873, 5565.0, 5566.805161819317, 3589.28214357127, 3682.4844521766972, 3695.7043436525014, 3727.422249551324, 3734.10381508436, 901.8286525560122, 1019.306871327497, 1044.6448207609374, 1062.097217365241, 1063.9360639360639, 9480.620775168985, 11502.424878756028, 11628.244164129304, 11640.476178571984, 11647.41762911851, 3895.5909629488497, 4651.418572678415, 4654.115718013567, 4731.1720448921305, 4786.928196077061, 9221.216196623229, 9236.399634023766, 9303.116203960748, 9306.2089722373, 9346.57940392684, 4381.364702118175, 5280.815171469057, 5310.60170487215, 5346.224797404355, 5482.91775623366, 4438.178936896685, 4861.7326047067045, 4961.330220420269, 4970.726610036482, 4982.3522942018035, 3955.7428767130045, 4035.9506528302268, 4038.45480860086, 4066.268071747055, 4075.083106301118, 1326.5688651188402, 1345.5357901523957, 1351.743168797945, 1356.4709763192363, 1369.1921766158014, 1331.2212355771787, 1335.2255691698792, 1365.242290528766, 1373.6291201375573, 1404.389090745529, 8108.351331893435, 8161.63272652732, 8188.5496297703, 8386.329093672492, 8400.873986890201, 1228.7051107734258, 1236.6970092327438, 1238.597455826842, 1245.9003279737599, 1256.1207154991544, 6273.780417685451, 6322.557420980579, 6372.936270637234, 6381.329960354189, 6414.61512309263, 10394.636187733393, 10739.248252622398, 10769.56921723138, 10775.78448431027, 10908.127349812155, 10582.523786429476, 10603.787924241473, 10607.57569697219, 10690.251682382159, 10699.83950240747, 8321.209485098905, 8322.334213262924, 8491.0, 8494.83010339802, 8594.87107693385, 7777.338926191337, 7943.165967573322, 7955.204479551999, 7999.720009799629, 8004.279614834692, 9390.812183756423, 9580.18568421692, 9607.423554586747, 9615.663451779154, 9777.608895644094, 9722.75693107678, 9997.650082247086, 10019.998000199921, 10027.147692446224, 10125.645602404174, 6380.234371875219, 6967.303269672992, 7048.400885924549, 7077.82305442368, 7175.103112110986, 8230.794230144294, 8233.711820086268, 8265.297449716601, 8293.751187464386, 8402.159784021549, 7304.306090921354, 7392.889106663297, 7424.70301187968, 7500.737474188377, 7559.584222867575, 7251.021112150003, 7286.016387787581, 7317.524360916524, 7344.522606030591, 7442.106947166375, 7699.076110866732, 7759.224077592421, 7760.961195193988, 7767.456278060482, 7779.805504862424, 6922.653867306715, 7024.227334993045, 7048.330408611174, 7048.400885924754, 7077.681504332214, 7152.105986751656, 7195.604241766753, 7235.746748863765, 7243.45674074457, 7276.0], "unit": "score", "name": "mootools.html", "value": 4981.911342777022}, {"lowerIsBetter": false, "replicates": [298.80428319450755, 326.29845831462353, 327.3436759297608, 331.6865213753536, 337.9070755542226, 6786.185657721074, 6877.243503214642, 6898.724051037965, 6911.239763626009, 6959.721611135555, 6752.291009443999, 6779.525433219676, 6803.931960680392, 6805.591664500133, 6821.316489095882, 4117.279476091687, 4697.342372067913, 4755.381800365947, 4886.633502487328, 4920.13897567926, 4868.367112275399, 4888.24232244001, 4899.265110233458, 4907.509249075099, 4909.729964851932, 4862.829800956967, 4875.390576177978, 4888.902221955559, 4893.632977526682, 4912.877178070541, 4878.487758785347, 4894.926576101361, 4905.852824415273, 4907.460179380265, 4914.803407863681, 4201.97899010503, 4222.619964203236, 4224.0, 4235.682323825695, 4242.172776308621, 5679.943200568024, 6089.786857459968, 6147.2008638877105, 6351.364863513658, 6437.259715132726, 5815.563832712522, 5874.265716785402, 5877.941220587825, 5880.529557635379, 5893.616914900518, 7029.086218791575, 7031.613261270628, 7064.32888875556, 7066.92933070673, 7072.787816365517, 4734.337192793012, 4742.691725037862, 4743.644226683013, 4766.475687674353, 4768.451628062782, 7489.887651685229, 7510.3616192623695, 7520.623968801593, 7523.3981281497345, 7540.321371076575, 3830.272248272875, 4677.695949763254, 4818.301346304836, 4847.660663753574, 4859.611231101503, 4901.411830580353, 4906.877328066756, 4916.360873086547, 4931.50684931504, 4939.802407903716, 5823.825285241365, 5827.863566604557, 5852.356240813507, 5870.4716575507555, 5899.262592175978, 7134.215236324, 7139.178994415709, 7159.176694680074, 7186.245444228385, 7196.568205907663, 1691.805442374118, 1723.9482815515303, 1727.8013028501882, 1729.887557308796, 1739.4086010756403, 1074.1192222377576, 1116.1573012375604, 1116.9273997190319, 1123.0902968595465, 1140.6920131564598, 6573.1783527059115, 6649.767258145942, 6671.366220209073, 6680.331966803281, 6690.765823196165, 6129.295131059896, 7403.889416587447, 7456.440766942501, 7473.327400533978, 7489.737859174903, 4530.592246697747, 6012.609180403259, 6340.714667839959, 6718.664066796739, 6767.35710107539, 3140.952885706716, 3970.344893092665, 4000.9399859002137, 4001.7598944063448, 4002.7398219115667, 7781.182975787574, 7828.921710782934, 7838.529688218725, 7860.213978602094, 7909.1299957004685, 6279.686015699197, 7553.962230188814, 7772.494787838772, 7775.533467991825, 7779.299863012243, 7818.218178182136, 7830.373570114377, 7845.137034926153, 7854.960725196337, 7879.803004924923, 6551.918933376131, 7142.357187853118, 7520.962395187989, 7540.736074237376, 7559.962200188964, 5942.61373010753, 6011.368806275453, 7396.445266605134, 7410.5183163094225, 7417.8145546361775, 7078.327558881898, 7631.590638713865, 7670.693172273047, 7813.218678132142, 7831.216878312123, 4882.2920676501, 4913.459519452929, 4931.48219436954, 4933.038057578881, 4938.456769755396, 7551.848963020819, 7554.206808285271, 7564.773056808304, 7568.394528437601, 7587.58268295249, 6368.395002474757, 6809.557378770364, 7285.235050319852, 7319.8536029280185, 7322.414206863332, 7078.504504684829, 7213.855722885408, 7269.927300726925, 7282.308180722823, 7302.2697730226555, 5462.535684466865, 7063.1524217094275, 7080.681369338289, 7086.964565177141, 7107.076080109553, 7157.928420715726, 7236.891446628199, 7255.020572222894, 7279.308465695751, 7288.67200975968, 7065.399441047569, 7072.646367681698, 7076.469264805057, 7076.716931322895, 7102.5028248022145], "unit": "score", "name": "prototype.html", "value": 5229.727664445454}, {"lowerIsBetter": false, "replicates": [647.2427260105676, 652.0773106054935, 677.1332694151484, 733.7578599062308, 766.2988365645434, 14706.117632942018, 14797.630059248524, 15027.549173524785, 15034.774478382806, 15105.697886042273, 11662.533498660065, 13816.654583635414, 13873.959453041038, 13902.09636373635, 13938.442462301497, 753.9821241324223, 920.8388532006906, 935.5649622925339, 935.6725146198844, 937.292344280071, 942.7454587261435, 948.2887834124407, 948.3551185194066, 949.8290307744603, 951.3198063384679, 971.9368241064308, 979.5494072726555, 981.102291403365, 981.362114625492, 981.6858605246324, 939.3659279985982, 952.4618590496382, 960.9087136722035, 969.3747532841348, 973.5813600151931, 695.401954319285, 715.5420530860254, 722.1586851318208, 725.1189804387694, 728.5228175545027, 15029.09825410468, 15048.473303434437, 15077.698446031018, 15078.773818392732, 15122.319495622613, 12722.554710585086, 12724.872751272462, 12774.425150868234, 12775.552855650008, 12892.097553171281, 8602.655893764242, 9869.703908882744, 10002.299839011272, 10022.799544009078, 10365.378077315385, 3424.161080535285, 3463.7767013973444, 3481.8259087045544, 3519.894403167909, 3594.4069228577514, 80628.19371806266, 80785.0, 80822.19177808205, 80923.0, 81476.59261703654, 9232.399894006869, 9402.576884040098, 9468.053194680615, 9639.759006024906, 9824.45965471906, 22086.558268834535, 22089.889550552143, 22104.668429973564, 22114.004869780576, 22127.0, 7233.168185658611, 7309.780706578811, 7352.0, 7596.392288617008, 7691.423143264165, 4060.634542891154, 4095.406166105898, 4124.237016152021, 4133.937990930139, 4159.916801664011, 3610.6930910872343, 3635.581908080552, 3636.2363903580017, 3643.3441980443777, 3663.4871118043493, 610.4140025575408, 640.4044238857907, 645.9870802583922, 659.4032400677395, 668.355037388922, 572.1617829879247, 580.0979476913355, 581.4505292498633, 593.9910901336483, 601.2964831147568, 7827.9608601956625, 7996.520208787491, 8048.718294859769, 8108.554029528433, 8278.875757274851, 500.2845930319605, 509.66362200947196, 534.593708781329, 590.8788698316835, 604.4650484321407, 3778.67881230093, 3778.962210377916, 3811.5807261201244, 3817.522809648794, 3820.84716611338, 84373.89065273418, 85264.72102918461, 86088.0, 86246.56876715577, 94722.0, 76536.1731913402, 77676.0, 78081.21918780853, 79030.0, 79090.0, 67880.28478860889, 68138.46115450807, 68352.65823670849, 68981.999999999, 69059.3094069063, 6911.412529935012, 7751.961240193763, 8362.498250105013, 8386.916130838857, 8677.435966662399, 32936.0, 46692.53307467018, 49200.0, 49285.50714492953, 50027.74986125192, 60807.0, 62720.0, 63247.05129423155, 63406.0, 63717.6814115945, 10583.300576682806, 10681.679549613524, 10751.13990880712, 10921.180911431515, 11359.659210223706, 11551.422428878355, 11845.111616628616, 11902.583409580624, 12108.455119519467, 12127.939360303142, 11026.558937642725, 11265.211435199457, 11328.37693926809, 11420.143489238175, 11592.0, 10919.727006824893, 10953.83569246478, 11234.494447749707, 11370.260933039326, 11486.712832179262, 10678.145748339959, 10931.125509959025, 11224.270422422516, 11329.433528323387, 11356.318620882774, 9320.673776417792, 9492.667756628762, 9532.61869525239, 9908.455034973145, 10109.494525273854, 9347.906520934703, 9458.952705236705, 9508.191803696487, 9537.284703647392, 9633.614655413705], "unit": "score", "name": "yui.html", "value": 6838.338117743271}], "name": "dromaeo_css", "value": 7520.848931106246}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 115.0, 114.0, 127.0, 116.0, 115.0, 117.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.0}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 144.0, 159.0, 117.0, 141.0, 142.0, 120.0, 163.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 138.0}, {"lowerIsBetter": true, "replicates": [190.0, 198.0, 195.0, 202.0, 193.0, 262.0, 254.0, 196.0, 200.0, 204.0], "unit": "score", "name": "audio-dft", "value": 209.4}, {"lowerIsBetter": true, "replicates": [77.0, 69.0, 55.0, 56.0, 52.0, 69.0, 93.0, 130.0, 73.0, 78.0], "unit": "score", "name": "audio-fft", "value": 75.2}, {"lowerIsBetter": true, "replicates": [79.0, 87.0, 120.0, 79.0, 83.0, 82.0, 121.0, 79.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 93.0}, {"lowerIsBetter": true, "replicates": [89.0, 88.0, 90.0, 77.0, 137.0, 86.0, 96.0, 130.0, 90.0, 106.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.9}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 96.0, 132.0, 112.0, 99.0, 91.0, 151.0, 90.0, 107.0], "unit": "score", "name": "imaging-darkroom", "value": 106.8}, {"lowerIsBetter": true, "replicates": [89.0, 123.0, 91.0, 145.0, 119.0, 91.0, 99.0, 92.0, 108.0, 151.0], "unit": "score", "name": "imaging-desaturate", "value": 110.8}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 67.0, 83.0, 87.0, 74.0, 55.0, 64.0, 58.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 68.0, 65.0, 72.0, 100.0, 109.0, 99.0, 78.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.8}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 85.0, 86.0, 85.0, 87.0, 86.0, 87.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [148.0, 115.0, 140.0, 141.0, 113.0, 144.0, 136.0, 135.0, 135.0, 152.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.9}, {"lowerIsBetter": true, "replicates": [130.0, 142.0, 138.0, 145.0, 143.0, 145.0, 144.0, 142.0, 150.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 66.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1525.4}]} 10:18:13 INFO - Return code: 0 10:18:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:18:13 ERROR - # TBPL SUCCESS # 10:18:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:13 INFO - 2016-03-11 10:18:13.640 screenresolution[1683:10389] starting screenresolution argv=screenresolution get 10:18:13 INFO - 2016-03-11 10:18:13.643 screenresolution[1683:10389] Display 0: 1600x1200x32@60 10:18:13 INFO - 2016-03-11 10:18:13.649 screenresolution[1684:10392] starting screenresolution argv=screenresolution list 10:18:13 INFO - Available Modes on Display 0 10:18:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:13 INFO - Intel Iris: 10:18:13 INFO - Chipset Model: Intel Iris 10:18:13 INFO - Type: GPU 10:18:13 INFO - Bus: Built-In 10:18:13 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:13 INFO - Vendor: Intel (0x8086) 10:18:13 INFO - Device ID: 0x0a2e 10:18:13 INFO - Revision ID: 0x0009 10:18:13 INFO - Displays: 10:18:13 INFO - Display: 10:18:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:13 INFO - Display Serial Number: 1600x1200 60 10:18:13 INFO - Main Display: Yes 10:18:13 INFO - Mirror: Off 10:18:13 INFO - Online: Yes 10:18:13 INFO - Rotation: Supported 10:18:13 INFO - Return code: 0 10:18:13 INFO - Running post-action listener: _resource_record_post_action 10:18:13 INFO - Running post-run listener: _resource_record_post_run 10:18:14 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 38974976; Write bytes: 706053120; Read time: 422; Write time: 3549 10:18:14 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402428416; Write bytes: 403027968; Read time: 30202; Write time: 748 10:18:14 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37160448; Write bytes: 302177280; Read time: 402; Write time: 2800 10:18:14 INFO - Running post-run listener: _upload_blobber_files 10:18:14 INFO - Blob upload gear active. 10:18:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:14 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 10:18:14 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'] 10:18:14 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 10:18:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:18:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:18:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:16 INFO - (blobuploader) - INFO - Done attempting. 10:18:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:18:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:18:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:17 INFO - (blobuploader) - INFO - Done attempting. 10:18:17 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:17 INFO - Return code: 0 10:18:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8d29939ea6c19cd887f255616a8e20fc493f7b80d33a6a5d56e2e021ffef454f28ea3eef18fff452f2dfa93c14b0f3daaa588550003d0a4e3dc237f03fbc15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede540a05817628b7d7792573d44a7b285412324a07ce45e0b28bee4e1b946ebef93be0eba98744952d84d98f1e657539c26fad5a60732e380c0a7d7c875cf61"} 10:18:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:17 INFO - Contents: 10:18:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8d29939ea6c19cd887f255616a8e20fc493f7b80d33a6a5d56e2e021ffef454f28ea3eef18fff452f2dfa93c14b0f3daaa588550003d0a4e3dc237f03fbc15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede540a05817628b7d7792573d44a7b285412324a07ce45e0b28bee4e1b946ebef93be0eba98744952d84d98f1e657539c26fad5a60732e380c0a7d7c875cf61"} 10:18:17 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:17 INFO - Copying logs to upload dir... 10:18:17 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.948742 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-03-11 10:18:17.427340) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 10:18:17.431115) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/1b8d29939ea6c19cd887f255616a8e20fc493f7b80d33a6a5d56e2e021ffef454f28ea3eef18fff452f2dfa93c14b0f3daaa588550003d0a4e3dc237f03fbc15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede540a05817628b7d7792573d44a7b285412324a07ce45e0b28bee4e1b946ebef93be0eba98744952d84d98f1e657539c26fad5a60732e380c0a7d7c875cf61"} build_url:https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/dG8L41JwQ7WzgLO4WI_vlg/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/1b8d29939ea6c19cd887f255616a8e20fc493f7b80d33a6a5d56e2e021ffef454f28ea3eef18fff452f2dfa93c14b0f3daaa588550003d0a4e3dc237f03fbc15", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ede540a05817628b7d7792573d44a7b285412324a07ce45e0b28bee4e1b946ebef93be0eba98744952d84d98f1e657539c26fad5a60732e380c0a7d7c875cf61"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-11 10:18:17.458733) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 10:18:17.459051) ========= 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.gCNBkMhIda/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.yEB4FcL6hM/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005176 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 10:18:17.507257) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 10:18:17.507580) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 10:18:17.507970) ========= ========= Total master_lag: 0.25 =========