builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0143 starttime: 1454109403.56 results: success (0) buildid: 20160129134127 builduid: 018f0c67b80d4e12810c983ecfd6911f revision: 54eea211e234217c0faa8c05bf4de9fd3005f5c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.563845) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.564222) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.564496) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005699 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.630426) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.630725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.743876) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.744140) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005754 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.827081) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.827361) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.827679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:43.827978) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-01-29 15:16:43-- 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% 14.7M=0.001s 2016-01-29 15:16:44 (14.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.604988 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:44.449068) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:44.449390) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.025426 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:44.498974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 15:16:44.499368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 54eea211e234217c0faa8c05bf4de9fd3005f5c2 --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 54eea211e234217c0faa8c05bf4de9fd3005f5c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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-01-29 15:16:44,572 truncating revision to first 12 chars 2016-01-29 15:16:44,572 Setting DEBUG logging. 2016-01-29 15:16:44,573 attempt 1/10 2016-01-29 15:16:44,573 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/54eea211e234?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 15:16:45,798 unpacking tar archive at: mozilla-central-54eea211e234/testing/mozharness/ program finished with exit code 0 elapsedTime=1.466673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 15:16:45.986747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:45.987070) ========= echo 54eea211e234217c0faa8c05bf4de9fd3005f5c2 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'54eea211e234217c0faa8c05bf4de9fd3005f5c2'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 54eea211e234217c0faa8c05bf4de9fd3005f5c2 program finished with exit code 0 elapsedTime=0.005329 script_repo_revision: '54eea211e234217c0faa8c05bf4de9fd3005f5c2' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:46.039236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:46.039524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 15:16:46.052672) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-29 15:16:46.052951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:16:46 INFO - MultiFileLogger online at 20160129 15:16:46 in /builds/slave/test 15:16:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:16:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:16:46 INFO - {'append_to_log': False, 15:16:46 INFO - 'base_work_dir': '/builds/slave/test', 15:16:46 INFO - 'blob_upload_branch': 'Firefox', 15:16:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:16:46 INFO - 'branch': 'Firefox', 15:16:46 INFO - 'buildbot_json_path': 'buildprops.json', 15:16:46 INFO - 'config_files': ('talos/mac_config.py',), 15:16:46 INFO - 'default_actions': ('clobber', 15:16:46 INFO - 'read-buildbot-config', 15:16:46 INFO - 'download-and-extract', 15:16:46 INFO - 'populate-webroot', 15:16:46 INFO - 'create-virtualenv', 15:16:46 INFO - 'install', 15:16:46 INFO - 'run-tests'), 15:16:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:16:46 INFO - 'download_minidump_stackwalk': True, 15:16:46 INFO - 'download_symbols': 'ondemand', 15:16:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:16:46 INFO - 'tooltool.py': '/tools/tooltool.py', 15:16:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:16:46 INFO - '/tools/misc-python/virtualenv.py')}, 15:16:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:16:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:16:46 INFO - 'installer_path': 'installer.exe', 15:16:46 INFO - 'log_level': 'info', 15:16:46 INFO - 'log_name': 'talos', 15:16:46 INFO - 'log_to_console': True, 15:16:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:16:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:16:46 INFO - 'opt_config_files': (), 15:16:46 INFO - 'pip_index': False, 15:16:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:46 INFO - 'cmd': ('bash', 15:16:46 INFO - '-c', 15:16:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:46 INFO - 'enabled': True, 15:16:46 INFO - 'halt_on_failure': False, 15:16:46 INFO - 'name': 'check_screen_resolution'},), 15:16:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:16:46 INFO - 'cmd': ('bash', 15:16:46 INFO - '-c', 15:16:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:16:46 INFO - 'enabled': True, 15:16:46 INFO - 'halt_on_failure': False, 15:16:46 INFO - 'name': 'check_screen_resolution'},), 15:16:46 INFO - 'run_cmd_checks_enabled': True, 15:16:46 INFO - 'sps_profile': False, 15:16:46 INFO - 'sps_profile_interval': 0, 15:16:46 INFO - 'suite': 'dromaeojs', 15:16:46 INFO - 'system_bits': '32', 15:16:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:16:46 INFO - 'title': 't-yosemite-r7-0143', 15:16:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:16:46 INFO - 'use_talos_json': True, 15:16:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:16:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:16:46 INFO - 'work_dir': 'build'} 15:16:46 INFO - ##### 15:16:46 INFO - ##### Running clobber step. 15:16:46 INFO - ##### 15:16:46 INFO - Running pre-action listener: _resource_record_pre_action 15:16:46 INFO - Running main action method: clobber 15:16:46 INFO - rmtree: /builds/slave/test/build 15:16:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:16:47 INFO - Running post-action listener: _resource_record_post_action 15:16:47 INFO - ##### 15:16:47 INFO - ##### Running read-buildbot-config step. 15:16:47 INFO - ##### 15:16:47 INFO - Running pre-action listener: _resource_record_pre_action 15:16:47 INFO - Running main action method: read_buildbot_config 15:16:47 INFO - Using buildbot properties: 15:16:47 INFO - { 15:16:47 INFO - "project": "", 15:16:47 INFO - "product": "firefox", 15:16:47 INFO - "script_repo_revision": "production", 15:16:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 15:16:47 INFO - "repository": "", 15:16:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 15:16:47 INFO - "buildid": "20160129134127", 15:16:47 INFO - "pgo_build": "False", 15:16:47 INFO - "basedir": "/builds/slave/test", 15:16:47 INFO - "buildnumber": 94, 15:16:47 INFO - "slavename": "t-yosemite-r7-0143", 15:16:47 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:16:47 INFO - "platform": "yosemite_r7", 15:16:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:16:47 INFO - "branch": "mozilla-central", 15:16:47 INFO - "repo_path": "mozilla-central", 15:16:47 INFO - "revision": "54eea211e234217c0faa8c05bf4de9fd3005f5c2", 15:16:47 INFO - "stage_platform": "macosx64", 15:16:47 INFO - "builduid": "018f0c67b80d4e12810c983ecfd6911f", 15:16:47 INFO - "slavebuilddir": "test" 15:16:47 INFO - } 15:16:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:16:47 INFO - Running post-action listener: _resource_record_post_action 15:16:47 INFO - ##### 15:16:47 INFO - ##### Running download-and-extract step. 15:16:47 INFO - ##### 15:16:47 INFO - Running pre-action listener: _resource_record_pre_action 15:16:47 INFO - Running main action method: download_and_extract 15:16:47 INFO - mkdir: /builds/slave/test/build/tests 15:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:16:47 INFO - https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/test_packages.json 15:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/test_packages.json 15:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:16:53 INFO - Downloaded 1277 bytes. 15:16:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:16:53 INFO - Using the following test package requirements: 15:16:53 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:16:53 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:16:53 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:16:53 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'jsshell-mac.zip'], 15:16:53 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:16:53 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:16:53 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:16:53 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:16:53 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:16:53 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:16:53 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:16:53 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:16:53 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:16:53 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')]} 15:16:53 INFO - https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:16:58 INFO - Downloaded 16722395 bytes. 15:16:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:16:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:17:01 INFO - Return code: 0 15:17:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:01 INFO - https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:17:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:17:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:17:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:17:02 INFO - Downloaded 16722395 bytes. 15:17:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:17:05 INFO - Return code: 0 15:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:05 INFO - https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:17:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:17:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:17:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:17:06 INFO - Downloaded 10706582 bytes. 15:17:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:17:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:17:06 INFO - Return code: 0 15:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:06 INFO - https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 15:17:11 INFO - Downloaded 111053779 bytes. 15:17:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:17:11 INFO - mkdir: /builds/slave/test/properties 15:17:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:17:11 INFO - Writing to file /builds/slave/test/properties/build_url 15:17:11 INFO - Contents: 15:17:11 INFO - build_url:https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:17:11 INFO - Running post-action listener: _resource_record_post_action 15:17:11 INFO - Running post-action listener: set_extra_try_arguments 15:17:11 INFO - ##### 15:17:11 INFO - ##### Running populate-webroot step. 15:17:11 INFO - ##### 15:17:11 INFO - Running pre-action listener: _resource_record_pre_action 15:17:11 INFO - Running main action method: populate_webroot 15:17:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:17:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:17:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:17:11 INFO - '--tppagecycles', 15:17:11 INFO - '7'], 15:17:11 INFO - 'tests': ['tsvgm']}}, 15:17:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:17:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:17:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:17:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:17:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:17:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'tests': ['damp', 'tps']}, 15:17:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['damp', 'tps']}, 15:17:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:17:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:17:11 INFO - 'other': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'other_l64': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'other_nol64': {'tests': ['a11yr', 15:17:11 INFO - 'ts_paint', 15:17:11 INFO - 'tpaint', 15:17:11 INFO - 'sessionrestore', 15:17:11 INFO - 'sessionrestore_no_auto_restore']}, 15:17:11 INFO - 'svgr': {'tests': ['tsvgx', 15:17:11 INFO - 'tsvgr_opacity', 15:17:11 INFO - 'tart', 15:17:11 INFO - 'tscrollx', 15:17:11 INFO - 'cart']}, 15:17:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['tsvgx', 15:17:11 INFO - 'tsvgr_opacity', 15:17:11 INFO - 'tart', 15:17:11 INFO - 'tscrollx', 15:17:11 INFO - 'cart']}, 15:17:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'tests': ['tp5o']}, 15:17:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'talos_options': ['--e10s'], 15:17:11 INFO - 'tests': ['tp5o']}, 15:17:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'talos_options': ['--xperf_path', 15:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:11 INFO - 'tests': ['tp5n']}, 15:17:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:17:11 INFO - 'talos_options': ['--e10s', 15:17:11 INFO - '--xperf_path', 15:17:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:17:11 INFO - 'tests': ['tp5n']}}, 15:17:11 INFO - 'talos.zip': {'path': '', 15:17:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:17:11 INFO - Running post-action listener: _resource_record_post_action 15:17:11 INFO - ##### 15:17:11 INFO - ##### Running create-virtualenv step. 15:17:11 INFO - ##### 15:17:11 INFO - Running pre-action listener: _resource_record_pre_action 15:17:11 INFO - Running main action method: create_virtualenv 15:17:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:17:11 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 15:17:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:17:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:17:11 INFO - Using real prefix '/tools/python27' 15:17:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:17:12 INFO - Installing distribute.............................................................................................................................................................................................done. 15:17:15 INFO - Installing pip.................done. 15:17:15 INFO - Return code: 0 15:17:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:17:15 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')]} 15:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 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')]} 15:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:15 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 15:17:15 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 15:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:15 INFO - 'HOME': '/Users/cltbld', 15:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:15 INFO - 'LOGNAME': 'cltbld', 15:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:15 INFO - 'MOZ_NO_REMOTE': '1', 15:17:15 INFO - 'NO_EM_RESTART': '1', 15:17:15 INFO - 'PAGER': '/bin/cat', 15:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:15 INFO - 'PWD': '/builds/slave/test', 15:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:15 INFO - 'SHELL': '/bin/bash', 15:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:15 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:15 INFO - 'USER': 'cltbld', 15:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:15 INFO - 'XPC_FLAGS': '0x0', 15:17:15 INFO - 'XPC_SERVICE_NAME': '0', 15:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:15 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 15:17:15 INFO - Cleaning up... 15:17:15 INFO - Return code: 0 15:17:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:17:15 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')]} 15:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 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')]} 15:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:15 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:15 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 15:17:15 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 15:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:15 INFO - 'HOME': '/Users/cltbld', 15:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:15 INFO - 'LOGNAME': 'cltbld', 15:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:15 INFO - 'MOZ_NO_REMOTE': '1', 15:17:15 INFO - 'NO_EM_RESTART': '1', 15:17:15 INFO - 'PAGER': '/bin/cat', 15:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:15 INFO - 'PWD': '/builds/slave/test', 15:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:15 INFO - 'SHELL': '/bin/bash', 15:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:15 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:15 INFO - 'USER': 'cltbld', 15:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:15 INFO - 'XPC_FLAGS': '0x0', 15:17:15 INFO - 'XPC_SERVICE_NAME': '0', 15:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:16 INFO - Downloading/unpacking psutil>=0.7.1 15:17:16 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 15:17:16 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 15:17:16 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 15:17:16 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 15:17:16 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 15:17:16 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 15:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:17:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:19 INFO - Installing collected packages: psutil 15:17:19 INFO - Running setup.py install for psutil 15:17:19 INFO - building 'psutil._psutil_osx' extension 15:17:19 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 15:17: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_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:17: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/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:17:20 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 15:17:20 INFO - building 'psutil._psutil_posix' extension 15:17:20 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 15:17:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:17:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:17:20 INFO - ^ 15:17:20 INFO - 1 warning generated. 15:17:20 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 15:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:17:20 INFO - Successfully installed psutil 15:17:20 INFO - Cleaning up... 15:17:20 INFO - Return code: 0 15:17:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:17:20 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')]} 15:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:20 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')]} 15:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:20 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:20 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 15:17:20 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 15:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:20 INFO - 'HOME': '/Users/cltbld', 15:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:20 INFO - 'LOGNAME': 'cltbld', 15:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:20 INFO - 'MOZ_NO_REMOTE': '1', 15:17:20 INFO - 'NO_EM_RESTART': '1', 15:17:20 INFO - 'PAGER': '/bin/cat', 15:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:20 INFO - 'PWD': '/builds/slave/test', 15:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:20 INFO - 'SHELL': '/bin/bash', 15:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:20 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:20 INFO - 'USER': 'cltbld', 15:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:20 INFO - 'XPC_FLAGS': '0x0', 15:17:20 INFO - 'XPC_SERVICE_NAME': '0', 15:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:17:20 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 15:17:20 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 15:17:20 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 15:17:20 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 15:17:20 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 15:17:20 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 15:17:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:17:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:17:23 INFO - Installing collected packages: mozsystemmonitor 15:17:23 INFO - Running setup.py install for mozsystemmonitor 15:17:23 INFO - Successfully installed mozsystemmonitor 15:17:23 INFO - Cleaning up... 15:17:23 INFO - Return code: 0 15:17:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:23 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:23 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 15:17:23 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 15:17:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:23 INFO - 'HOME': '/Users/cltbld', 15:17:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:23 INFO - 'LOGNAME': 'cltbld', 15:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:23 INFO - 'MOZ_NO_REMOTE': '1', 15:17:23 INFO - 'NO_EM_RESTART': '1', 15:17:23 INFO - 'PAGER': '/bin/cat', 15:17:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:23 INFO - 'PWD': '/builds/slave/test', 15:17:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:23 INFO - 'SHELL': '/bin/bash', 15:17:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:23 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:23 INFO - 'USER': 'cltbld', 15:17:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:23 INFO - 'XPC_FLAGS': '0x0', 15:17:23 INFO - 'XPC_SERVICE_NAME': '0', 15:17:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:23 INFO - Downloading/unpacking blobuploader==1.2.4 15:17:23 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 15:17:23 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 15:17:23 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 15:17:23 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 15:17:23 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 15:17:23 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 15:17:25 INFO - Downloading blobuploader-1.2.4.tar.gz 15:17:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:17:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:17:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:26 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 15:17:27 INFO - Downloading docopt-0.6.1.tar.gz 15:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:17:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:17:27 INFO - Running setup.py install for blobuploader 15:17:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:17:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:17:27 INFO - Running setup.py install for requests 15:17:27 INFO - Running setup.py install for docopt 15:17:27 INFO - Successfully installed blobuploader requests docopt 15:17:27 INFO - Cleaning up... 15:17:28 INFO - Return code: 0 15:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:28 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:28 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 15:17:28 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 15:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:28 INFO - 'HOME': '/Users/cltbld', 15:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:28 INFO - 'LOGNAME': 'cltbld', 15:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:28 INFO - 'MOZ_NO_REMOTE': '1', 15:17:28 INFO - 'NO_EM_RESTART': '1', 15:17:28 INFO - 'PAGER': '/bin/cat', 15:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:28 INFO - 'PWD': '/builds/slave/test', 15:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:28 INFO - 'SHELL': '/bin/bash', 15:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:28 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:28 INFO - 'USER': 'cltbld', 15:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:28 INFO - 'XPC_FLAGS': '0x0', 15:17:28 INFO - 'XPC_SERVICE_NAME': '0', 15:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ylqLnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-OD79dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-0CtK1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-NzXF69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-V6manX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-egvQvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:28 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-ztLWDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-jqPvir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-pEF8gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Um_s7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gkhYsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-8MJSW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-TDwlWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-um2LHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-KX_maM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-K1u27X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:29 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-vkdj4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:17:30 INFO - Running setup.py install for manifestparser 15:17:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:17:30 INFO - Running setup.py install for mozcrash 15:17:30 INFO - Running setup.py install for mozdebug 15:17:30 INFO - Running setup.py install for mozdevice 15:17:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:17:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:17:30 INFO - Running setup.py install for mozfile 15:17:30 INFO - Running setup.py install for mozhttpd 15:17:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:17:30 INFO - Running setup.py install for mozinfo 15:17:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Running setup.py install for mozInstall 15:17:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Running setup.py install for mozleak 15:17:31 INFO - Running setup.py install for mozlog 15:17:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Running setup.py install for moznetwork 15:17:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:17:31 INFO - Running setup.py install for mozprocess 15:17:31 INFO - Running setup.py install for mozprofile 15:17:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:17:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:17:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:17:32 INFO - Running setup.py install for mozrunner 15:17:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:17:32 INFO - Running setup.py install for mozscreenshot 15:17:32 INFO - Running setup.py install for moztest 15:17:32 INFO - Running setup.py install for mozversion 15:17:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:17:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:17:32 INFO - Cleaning up... 15:17:32 INFO - Return code: 0 15:17:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:32 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')]} 15:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:32 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')]} 15:17:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:32 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:32 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 15:17:32 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 15:17:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:32 INFO - 'HOME': '/Users/cltbld', 15:17:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:32 INFO - 'LOGNAME': 'cltbld', 15:17:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:32 INFO - 'MOZ_NO_REMOTE': '1', 15:17:32 INFO - 'NO_EM_RESTART': '1', 15:17:32 INFO - 'PAGER': '/bin/cat', 15:17:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:32 INFO - 'PWD': '/builds/slave/test', 15:17:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:32 INFO - 'SHELL': '/bin/bash', 15:17:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:32 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:32 INFO - 'USER': 'cltbld', 15:17:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:32 INFO - 'XPC_FLAGS': '0x0', 15:17:32 INFO - 'XPC_SERVICE_NAME': '0', 15:17:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:17:32 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-L6yIAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Mqu14T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-YJhX8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-rDBQ76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-Hct7QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-4U9AOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-jcF7ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-xPgQqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-gQrQH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-xYg2MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:17:33 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)) 15:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:17:33 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-lD0r8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-AjbGTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-li1SqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-vyllva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-RwbEJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-_A2TeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:17:34 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)) 15:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:17:34 INFO - Running setup.py (path:/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/pip-MO4NsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:17:34 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)) 15:17:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:17:34 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)) 15:17:34 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)) 15:17:34 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)) 15:17:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:34 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 15:17:36 INFO - Downloading blessings-1.6.tar.gz 15:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:17:37 INFO - Installing collected packages: blessings 15:17:37 INFO - Running setup.py install for blessings 15:17:37 INFO - Successfully installed blessings 15:17:37 INFO - Cleaning up... 15:17:37 INFO - Return code: 0 15:17:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:17:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:37 INFO - Reading from file tmpfile_stdout 15:17:37 INFO - Current package versions: 15:17:37 INFO - blessings == 1.6 15:17:37 INFO - blobuploader == 1.2.4 15:17:37 INFO - docopt == 0.6.1 15:17:37 INFO - manifestparser == 1.1 15:17:37 INFO - mozInstall == 1.12 15:17:37 INFO - mozcrash == 0.16 15:17:37 INFO - mozdebug == 0.1 15:17:37 INFO - mozdevice == 0.48 15:17:37 INFO - mozfile == 1.2 15:17:37 INFO - mozhttpd == 0.7 15:17:37 INFO - mozinfo == 0.9 15:17:37 INFO - mozleak == 0.1 15:17:37 INFO - mozlog == 3.1 15:17:37 INFO - moznetwork == 0.27 15:17:37 INFO - mozprocess == 0.22 15:17:37 INFO - mozprofile == 0.28 15:17:37 INFO - mozrunner == 6.11 15:17:37 INFO - mozscreenshot == 0.1 15:17:37 INFO - mozsystemmonitor == 0.0 15:17:37 INFO - moztest == 0.7 15:17:37 INFO - mozversion == 1.4 15:17:37 INFO - psutil == 3.1.1 15:17:37 INFO - requests == 1.2.3 15:17:37 INFO - wsgiref == 0.1.2 15:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:37 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 15:17:37 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 15:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:37 INFO - 'HOME': '/Users/cltbld', 15:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:37 INFO - 'LOGNAME': 'cltbld', 15:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:37 INFO - 'MOZ_NO_REMOTE': '1', 15:17:37 INFO - 'NO_EM_RESTART': '1', 15:17:37 INFO - 'PAGER': '/bin/cat', 15:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:37 INFO - 'PWD': '/builds/slave/test', 15:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:37 INFO - 'SHELL': '/bin/bash', 15:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:37 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:37 INFO - 'USER': 'cltbld', 15:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:37 INFO - 'XPC_FLAGS': '0x0', 15:17:37 INFO - 'XPC_SERVICE_NAME': '0', 15:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 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)) 15:17:37 INFO - Cleaning up... 15:17:37 INFO - Return code: 0 15:17:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:37 INFO - 'HOME': '/Users/cltbld', 15:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:37 INFO - 'LOGNAME': 'cltbld', 15:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:37 INFO - 'MOZ_NO_REMOTE': '1', 15:17:37 INFO - 'NO_EM_RESTART': '1', 15:17:37 INFO - 'PAGER': '/bin/cat', 15:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:37 INFO - 'PWD': '/builds/slave/test', 15:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:37 INFO - 'SHELL': '/bin/bash', 15:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:37 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:37 INFO - 'USER': 'cltbld', 15:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:37 INFO - 'XPC_FLAGS': '0x0', 15:17:37 INFO - 'XPC_SERVICE_NAME': '0', 15:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:38 INFO - Downloading/unpacking jsonschema 15:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:17:40 INFO - Downloading/unpacking functools32 (from jsonschema) 15:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:40 INFO - Downloading functools32-3.2.3-2.tar.gz 15:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:17:40 INFO - warning: no files found matching '*.txt' 15:17:40 INFO - no previously-included directories found matching 'build' 15:17:40 INFO - no previously-included directories found matching 'dist' 15:17:40 INFO - no previously-included directories found matching '.git*' 15:17:40 INFO - Installing collected packages: jsonschema, functools32 15:17:40 INFO - Running setup.py install for functools32 15:17:41 INFO - warning: no files found matching '*.txt' 15:17:41 INFO - no previously-included directories found matching 'build' 15:17:41 INFO - no previously-included directories found matching 'dist' 15:17:41 INFO - no previously-included directories found matching '.git*' 15:17:41 INFO - Successfully installed jsonschema functools32 15:17:41 INFO - Cleaning up... 15:17:41 INFO - Return code: 0 15:17:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:17:41 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 0x10bf99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe92cb1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, '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.bmStMmMYXy/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.jwrKhUg0FM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/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 15:17:41 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 15:17:41 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 15:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:17:41 INFO - 'HOME': '/Users/cltbld', 15:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:17:41 INFO - 'LOGNAME': 'cltbld', 15:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:17:41 INFO - 'MOZ_NO_REMOTE': '1', 15:17:41 INFO - 'NO_EM_RESTART': '1', 15:17:41 INFO - 'PAGER': '/bin/cat', 15:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:17:41 INFO - 'PWD': '/builds/slave/test', 15:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:17:41 INFO - 'SHELL': '/bin/bash', 15:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:17:41 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:17:41 INFO - 'USER': 'cltbld', 15:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:17:41 INFO - 'XPC_FLAGS': '0x0', 15:17:41 INFO - 'XPC_SERVICE_NAME': '0', 15:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:17:41 INFO - Downloading/unpacking flake8 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17: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 15:17:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:17:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:17:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:43 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 15:17:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:17:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:17:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:17:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:17:44 INFO - no previously-included directories found matching 'docs/_build' 15:17:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:17:44 INFO - Running setup.py install for pep8 15:17:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:17:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:17:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:17:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:17:45 INFO - no previously-included directories found matching 'docs/_build' 15:17:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:17:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:17:45 INFO - Cleaning up... 15:17:45 INFO - Return code: 0 15:17:45 INFO - Running post-action listener: _resource_record_post_action 15:17:45 INFO - Running post-action listener: _start_resource_monitoring 15:17:45 INFO - Starting resource monitoring. 15:17:45 INFO - ##### 15:17:45 INFO - ##### Running install step. 15:17:45 INFO - ##### 15:17:45 INFO - Running pre-action listener: _resource_record_pre_action 15:17:45 INFO - Running main action method: install 15:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:17:45 INFO - Reading from file tmpfile_stdout 15:17:45 INFO - Detecting whether we're running mozinstall >=1.0... 15:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:17:45 INFO - Reading from file tmpfile_stdout 15:17:45 INFO - Output received: 15:17:45 INFO - Usage: mozinstall [options] installer 15:17:45 INFO - Options: 15:17:45 INFO - -h, --help show this help message and exit 15:17:45 INFO - -d DEST, --destination=DEST 15:17:45 INFO - Directory to install application into. [default: 15:17:45 INFO - "/builds/slave/test"] 15:17:45 INFO - --app=APP Application being installed. [default: firefox] 15:17:45 INFO - mkdir: /builds/slave/test/build/application 15:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:18:19 INFO - Reading from file tmpfile_stdout 15:18:19 INFO - Output received: 15:18:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:18:19 INFO - Running post-action listener: _resource_record_post_action 15:18:19 INFO - ##### 15:18:19 INFO - ##### Running run-tests step. 15:18:19 INFO - ##### 15:18:19 INFO - Running pre-action listener: _resource_record_pre_action 15:18:19 INFO - Running main action method: run_tests 15:18:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:18:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:18:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:18:19 INFO - 2016-01-29 15:18:19.334 screenresolution[1661:8292] starting screenresolution argv=screenresolution get 15:18:19 INFO - 2016-01-29 15:18:19.337 screenresolution[1661:8292] Display 0: 1600x1200x32@60 15:18:19 INFO - 2016-01-29 15:18:19.343 screenresolution[1662:8294] starting screenresolution argv=screenresolution list 15:18:19 INFO - Available Modes on Display 0 15:18:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:18:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:18:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:18:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:18:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:18:19 INFO - Intel Iris: 15:18:19 INFO - Chipset Model: Intel Iris 15:18:19 INFO - Type: GPU 15:18:19 INFO - Bus: Built-In 15:18:19 INFO - VRAM (Dynamic, Max): 1536 MB 15:18:19 INFO - Vendor: Intel (0x8086) 15:18:19 INFO - Device ID: 0x0a2e 15:18:19 INFO - Revision ID: 0x0009 15:18:19 INFO - Displays: 15:18:19 INFO - Display: 15:18:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:18:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:18:19 INFO - Display Serial Number: 1600x1200 60 15:18:19 INFO - Main Display: Yes 15:18:19 INFO - Mirror: Off 15:18:19 INFO - Online: Yes 15:18:19 INFO - Rotation: Supported 15:18:19 INFO - Return code: 0 15:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:18:19 INFO - Python 2.7.3 15:18:19 INFO - Return code: 0 15:18:19 INFO - grabbing minidump binary from tooltool 15:18:19 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')]} 15:18:19 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 0x10be3ed30>, '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 0x10bc61db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be34b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:18:19 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 15:18:19 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 15:18:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:18:19 INFO - Return code: 0 15:18:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:18:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:18:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:18:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:18:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:18:20 INFO - Return code: 0 15:18:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:18:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0143 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:18:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bmStMmMYXy/Render', 15:18:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:18:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:18:20 INFO - 'HOME': '/Users/cltbld', 15:18:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:18:20 INFO - 'LOGNAME': 'cltbld', 15:18:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:18:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:18:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:18:20 INFO - 'MOZ_NO_REMOTE': '1', 15:18:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:18:20 INFO - 'NO_EM_RESTART': '1', 15:18:20 INFO - 'PAGER': '/bin/cat', 15:18:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:18:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:18:20 INFO - 'PWD': '/builds/slave/test', 15:18:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:18:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:18:20 INFO - 'SHELL': '/bin/bash', 15:18:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jwrKhUg0FM/Listeners', 15:18:20 INFO - 'TMPDIR': '/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/', 15:18:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:18:20 INFO - 'USER': 'cltbld', 15:18:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:18:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:18:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:18:20 INFO - 'XPC_FLAGS': '0x0', 15:18:20 INFO - 'XPC_SERVICE_NAME': '0', 15:18:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:18:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0143', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:18:21 INFO - mozversion application_buildid: 20160129134127 15:18:21 INFO - mozversion application_changeset: 54eea211e234217c0faa8c05bf4de9fd3005f5c2 15:18:21 INFO - mozversion application_display_name: Nightly 15:18:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:18:21 INFO - mozversion application_name: Firefox 15:18:21 INFO - mozversion application_remotingname: firefox 15:18:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:18:21 INFO - mozversion application_vendor: Mozilla 15:18:21 INFO - mozversion application_version: 47.0a1 15:18:21 INFO - mozversion platform_buildid: 20160129134127 15:18:21 INFO - mozversion platform_changeset: 54eea211e234217c0faa8c05bf4de9fd3005f5c2 15:18:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:18:21 INFO - mozversion platform_version: 47.0a1 15:18:21 INFO - using testdate: 1454109501 15:18:21 INFO - actual date: 1454109501 15:18:21 INFO - starting webserver on 'localhost:49272' 15:18:21 INFO - SUITE-START | Running 2 tests 15:18:21 INFO - TEST-START | dromaeo_css 15:18:21 INFO - operating with platform_type : mac_ 15:18:21 INFO - Initialising browser for dromaeo_css test... 15:18:21 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpLAt4X0/profile http://localhost:49272/getInfo.html) 15:18:23 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 15:18:23 INFO - PROCESS | 1680 | colorDepth:24 15:18:23 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 15:18:23 INFO - PROCESS | 1680 | __metrics 15:18:23 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:18:23 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:18:23 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:18:24 INFO - TEST-INFO | 1680: exit 0 15:18:24 INFO - Browser initialized. 15:18:24 INFO - Running cycle 1/1 for dromaeo_css test... 15:18:24 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpLAt4X0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:36 INFO - PROCESS | 1684 | RSS: Main: 241479680 15:18:36 INFO - PROCESS | 1684 | 15:19:27 INFO - PROCESS | 1684 | 1454109567976 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] 15:21:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 15:21:39 INFO - PROCESS | 1684 | RSS: Main: 349310976 15:21:39 INFO - PROCESS | 1684 | 15:24:41 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 15:24:42 INFO - PROCESS | 1684 | RSS: Main: 384106496 15:24:42 INFO - PROCESS | 1684 | 15:27:44 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 15:27:45 INFO - PROCESS | 1684 | RSS: Main: 378904576 15:27:45 INFO - PROCESS | 1684 | 15:30:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 15:30:47 INFO - PROCESS | 1684 | RSS: Main: 340987904 15:30:47 INFO - PROCESS | 1684 | 15:33:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 15:33:51 INFO - PROCESS | 1684 | RSS: Main: 341626880 15:33:51 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 15:36:54 INFO - PROCESS | 1684 | RSS: Main: 410828800 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | __start_tp_report 15:36:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 15:36:54 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 15:36:54 INFO - PROCESS | 1684 | |i|pagename|runs| 15:36:54 INFO - PROCESS | 1684 | |0;dojo.html;3415.6584341565845;3436.7078798302127;3456.3087382523486;3487.0062032320793;3512.8770493032735;5460.262864513289;5508.39407665157;5525.751341189646;5544.77820887164;5583.441655834425;5505.642133261335;5587.469190426903;5593.384727679962;5676.772929082842;5691.231683722696;5005.399352077756;5065.594752419806;5074.086664400406;5094.1085310070775;5126.000429916168;5106.489351064901;5108.20822772469;5109.744512774365;5132.769025393866;5148.536631703146;5000.599952003831;5065.088284108877;5067.01193267313;5081.79672813087;5097.949020509822;5075.238714192864;5097.745112744385;5101.15830887903;5109.182530795092;5121.436641969381;4972.303877457159;5045.621578381636;5061.898762024775;5062.31658726071;5068.366454193226;5364.839054828361;5394.568434525228;5398.24424580559;5422.701751403672;5453.481919217668;6082.96958515209;6089.804395363034;6094.146819445237;6110.29731580865;6111.755529778803;6082.209312789353;6168.167297414837;6168.845778855564;6172.814815555541;6180;5517.531009864167;5567.805126820583;5579.888402231933;5618.213450116987;5633.971830140823;6166.969165154235;6268.561200715906;6276.466500347522;6285.182926219562;6308.905366419507;5806.854828629233;5967.880642387128;5969.76120955157;5988.221531201003;5995.160677505153;6024.036154215392;6101.247350682792;6132.294786099566;6151.446369826737;6167.229096362955;5828.388019257917;5887.61730487517;5895.086261629454;5908.261467316585;5944.583879128506;6069.15031895535;6079.848003799941;6104.145419641254;6106.664133472702;6114.57197996136;4758.119747846659;4811.158047341772;4811.49479304675;4812.663113582085;4827.468978412372;4282.571742825692;4283.828646854154;4323.459567554056;4327.6321512671775;4336.934945975813;5609.298837645294;5635.746391412396;5650.830475085754;5662.320521537442;5675.091985282335;6068.666223357669;6116.296625887991;6158.599691020069;6176.969115154486;6181.381861813783;5634.6337488063145;5634.802781902614;5653.858653533694;5723.570732195102;5724.026915424388;5244.501772331622;5251.474852514718;5266.078436273637;5268.841934741964;5298;6251.906221406683;6258.061290806416;6262.749490020348;6262.968685156545;6269.81190564293;5522.558195344443;5625.774969001194;6085.817425477243;6094.116353128683;6105.114758359924;6114.297368145999;6273.686315684289;6274.560780745304;6275.843103922439;6279.215098112736;5988.910166347421;6047.312553656988;6051;6055.7577696893395;6107.69461526913;6007.30915944672;6123.309763056693;6126.326104128631;6130.5402094842175;6159.5688301818445;4697.483276839614;5040.798368065236;5769.653820770767;5953.6725480097275;5958.463738263404;5902.940970590239;5923.052311630118;5929;5936.1986131871645;5943.762249509971;5630.465105814941;5664.85837854057;5820.534357251495;5842.211301474416;5853.414658534112;5794.0439827428;5840.912386314124;5850.12248162779;5883.411658834082;5887.146363777314;5747;5771.047777116896;5773;5775.451332123442;5784.4504772046585 15:36:54 INFO - PROCESS | 1684 | |1;ext.html;436.08422313142404;465.07218099890724;506.8606133313338;547.4252035362871;561.8033688209126;29746.835443037966;36668.816655916715;36918.44622330667;36986.26027479449;37003.81498092506;41173.58826411735;41493.792531037376;41575;41620.58379416205;41643.79178104105;9524.809503809936;9761.463119528424;9766.951165244163;9770.071843174886;9789.412635241908;9544.809103817954;9681.709548713514;9695.272854535939;9710.465924374157;9859.950700246489;8478.78803029923;9846.803063938753;9870.062344077302;9876;9878.221920054388;9764.316497845119;9801.362911410735;9818.803623927553;9831.901680983241;9841.852372214422;9696;9791.755206119833;9819.509024548744;9839.262055345878;9842.458664773434;39667.809965701075;39910;40029;40050;40113.99715007119;3079.245584831708;3168.429682657121;3234;3355.7147642450423;3582.659647333499;27920;29024.129276121752;29672.554911676343;29706.554401683992;29803;2712.972870271292;2813.9296517587018;2831.9716802831913;2843.8720257588457;2885.264257614295;480573;480694;481716;482924;483031;54316.45683543193;55182.17226741602;55229;61115.38884611186;63832;60827.695861520406;61161.69419152876;61392.69303653453;61707;61762;14890.181040042686;16091.67816643684;16250.781191410691;16296.34814607426;16329.755053674204;11294.435278236055;11323.980841724284;12513.436895339732;12760.532538757976;13024.869751302555;16463.83536164623;17158.88467249625;19014.42956711301;19052.428427147206;19095.52261193481;6068.514518838482;7832.216778322122;7864.803379915548;7902.960485197537;7975.082865470546;943.8112377524523;962.31675510387;1066.0778426661038;1068.2041878800187;1070.6252811515908;26426.603600946;26444.206673799432;26532.469350613264;29415;30361.696383036327;1068.289587424354;1077.9191560632985;1085.0776839686202;1115.1914861725184;1135.5514571744116;13232.669183270302;13417.329133543284;13507.797383039262;13530.93234533821;13574.728505429835;529183;537941;538608;539554;539878;55044.724776375864;55414;55433.89132217333;55508.16737748937;55524.44475555274;1408.5774267719644;1415.7310111078862;1432.0834665814095;1436.0665567381286;1444.3534370817276;26960.460790783683;27167.320816979733;27641.308967275978;27659.58510622302;27661;47807.76096119636;48003.5199647999;48110.759446202544;48268.79328016687;48284.03431931271;492665;494974;502223;502891;505999;28687.71312286934;29081.709182908748;29089.7091029087;29193.562096568992;29297.85351073231;40347;40919;40990.79504602458;41402.585974141075;42056.78971605122;34893.8255308732;35725.64274357223;36176.819115904254;36347;36537.451938220416;35145.64854351424;35870.8206458966;36002.01988890636;36189.457158143174;36283.45574816327;35255.82372088123;35937.46093808542;35953.28093438169;36240.81879590585;36303.455448168825;30264.54603180998;31984.52023219607;32065.51901721523;32068;32104;23410.76589234086;23856.92643830997;24287.975076027273;24450.388740281636;24461.633075504236 15:36:54 INFO - PROCESS | 1684 | |2;jquery.html;323.256510026938;362.2736413490951;368.30206758193214;368.9003968928391;373.3745975491054;14756.852431475681;15096.773548396783;19461.902690486546;20574.691379629297;21085.367438976817;15964.201789910487;18899.52751181221;19417;20095.59808803823;20116.798832011675;5595.300587426572;5609.831705048855;5768.480836724694;5824.301083869942;5828.154917536955;4133.979330103345;4355.412019377391;4809.374781278429;5793.594448388614;5858;6162.322144564095;6289.842753931165;6305.022721478178;6316.1788967434395;6316.399942005502;6185.938140618581;6274.341194174637;6292.402221788922;6296.464800491964;6311.305756366796;5299.4700529946695;5416.295881535375;5428.891422171574;5453.15476101201;5459.181122831607;21005.36983890486;21129.788702112935;23810.64284035741;24853.627195592082;24907.750922490904;1957.4910523263911;2073.6163809695254;2075.813176814079;2135.3807395855183;2196.846220764547;9475.810483790285;9502.4298542087;9547.188488978445;9730.12428881404;9876.851847222297;1680.7983042035034;1769.195016267595;1770.2918832466987;1789.7852257729025;1821.4754946848743;91900;101650.49174754079;101673;102049.99999999926;103313.48343258236;8929.374943754005;10838.615504588977;11012.944935275433;11013.504392302366;11102.888971110347;12366.319852408204;13223.272720000492;13229.404676789567;13251.801222981663;13305.933470332586;8181.509109453452;8312.792180195422;8367.874481882776;8457.619407126695;8457.788555286166;7063.82340441493;8540.27407670355;8549.316054715608;8576.013758417861;8612.741617751477;4186.979065104655;4263.957360426418;4275.358696195595;4310.267254566731;4313.568643135662;1717.7079896417638;1771.4685594321652;1785.4554360920044;1788.7227479740661;1838.9448316550258;852.9147085291545;896.4710820615737;915.0437792506714;918.995405022984;1040.9063184313447;17249.22378492971;18586.25654973786;18696.906515467337;19330;20106.899465502578;769.7305942920045;798.66456088443;885.8793626063035;1001.4942454060798;1031.3554028732042;10083.042110999444;10448.843267350996;10461.895381046244;10487.842682359771;10573.735656608493;759072;760656;761369;775786;779427;110961;116938.94672047728;117331;119011;120929;1205.2166092040068;1205.3069485046133;1267.5563552756646;1284.9614511564669;1296.572131196703;17046.82953170502;17127.571810704332;17132.314707411562;17284.481465556055;17543.649127017132;46284.305735414666;46526.069478610916;47553.28670069882;47616.52383476121;48570.51429485801;61908;64133.358666412736;65202.673986631664;65945.67027164834;65974;7206.423486121203;7324.7070117196845;7383.335499805044;7499.287567681062;7559.3196612305155;10422.478876056015;11691;11853.5851245206;11882.16824822254;12003.519859205533;7396.704131834666;10496.842547361948;10505.31715438494;10510.842337364793;10694.62568810088;8697.91302086971;9836.950815245878;9917.512373143798;10505.579776808841;10580.470976450993;8255.504669719836;8735.868961965703;10386.323598739427;10849;10998.230123891251;5677.3754886963225;7461.141968673672;7583.014208152905;7592.582407967615;7622.352100071556;9331.486768227813;10442.373457592568;10480.266381353536;10619.36283822973;10664.46677666098 15:36:54 INFO - PROCESS | 1684 | |3;mootools.html;1417.8227721534809;1553.2466753624492;1580.596947778316;1839.7240413937907;1991.332903477335;7910.129885712574;8089.271965523102;8505.362097842662;8691.39160258782;8696.826063478742;8595.18345757152;8612.39713220075;8801.515916624583;8802.07578204289;8814.206721395074;1998.4004798560447;2233.0286325448483;2343.5078633486987;2484.1305543059966;2508.147229941819;2266.286119872243;2270.330252575486;2275.3742720751843;2275.9658605120935;2280.5894938910988;2291.209532711212;2352.494213744045;2358.422186564294;2360.0205914545445;2362.621980483123;2440.804735621155;2472.0235506974736;2485.6395822605623;2486.415692312305;2489.788367988723;2104.0531760707745;2168.0677308757226;2171.695962565242;2173.5326904715403;2481.9131330403347;7873.724419645342;8305.584720763998;8477.872831907527;8525.403221774479;8530;5224.555912747421;5405.324334458192;5410.91883621746;5450.945490545123;5461.42655021225;3555.6088830228655;3617.5116359291424;3657.414813629833;3670;3686.3548878946076;1052.1319911073394;1066.6799960011965;1071.560660129351;1101.6474728087014;1102.8345748137763;11983.880161198364;12051.517939282418;12070.758584828254;12112.333821639806;12116;4851.840930785766;4866.95133048665;4945.208766597327;4996.225585034253;5038.0931432341795;10329.690109296733;10330.276880618434;10353.948230258951;10355.585776569003;10358.53386597605;5507.779688812403;5514.228008078872;5536.2249285100115;5558.499735023786;5562.833115006556;4945.258211268267;4993.90012199754;5019.996000799854;5030.245463180479;5034.874128146753;3784.6026167252594;3809.8666546670734;3828.1386687994977;3850.114473671071;3874.593167717349;1256.58532684214;1263.911526193176;1270.656922630903;1272.0904553244475;1286.5754301080622;1331.4474493085454;1343.657367371314;1365.528892532075;1368.213277365499;1371.136184203945;7960.681572737141;8151.062627797761;8153;8172.42793004484;8175.1416101308505;512.8769095417073;520.9270702101709;525.90796610593;528.9735513224323;530.3794560364383;5809.564282678816;5886.175935369051;5983.1623572699855;6189.597676151036;6205.379462053849;10527.052565269163;10727.356358618508;10941.343519388862;10995.670129896116;11021.669349919515;10591.364518128938;10661.307015043998;10668.093212077061;10736.033756961911;10737.711474623095;6963.582185068912;8232.053313868862;8305.750827475305;8397.874031889527;8406.789830254293;8101.10887802353;8103.918960810553;8104.432689711663;8112.675492980215;8154.592270386338;9361.719148425558;9502.097300756417;9679.806403871742;9844.310898237054;9864.654737084167;9743.951280243553;10010.948850370607;10011.54948027326;10068.89931100709;10209.285350025724;7418.295261950106;7473.626318683935;7477.925220747723;7483.962580187064;7485.625718714152;7942.563159026309;8126.634301456331;8144.918550814416;8210.425270231026;8225.876611850706;7672.5012874163;7707.730229441942;7799.688012479437;7844;7871.803204919923;7325.4872158948365;7383.2985866342615;7485.1766305707415;7513.248675132443;7537.54774713519;7522.322990930624;7567.243275672609;7597.810054748676;7654.464187506821;7674.386049116169;6909.585424874524;6943.236244013256;6948.861022779617;6957.686904089227;6971.477139214478;6963.059986901703;7000.964995174992;7037.577745335297;7045.084139061889;7141.285871413025 15:36:54 INFO - PROCESS | 1684 | |4;prototype.html;323.4049349197477;331.5739275031585;335.0150557361356;337.46680245212565;340.5113661895179;6428.807135785928;6452.58058226215;6485.156929599151;6491.805245842632;6496.187976502937;6386.233651961771;6393.808185754435;6413.967930160355;6416.743330266795;6460.192475940507;4699.718016918979;4848.806047758086;4869.123557759593;4877.317175595419;4879.975600121995;4485.035717320776;4831.855044348676;4852.878678033042;4871.098846713352;4874.902501949959;3668.724845636588;4269.829206831723;4665.486796452387;4797.544233297831;4829.348038014876;4555.498895121534;4693.671442998992;4711.151992641323;4811.615070794345;4821.855344339693;4067.959320406788;4136.544980052192;4161.646260067898;4164.708470407073;4182.247195504808;5205.687658740488;6068.241469816273;6232.844178895519;6233.376662333776;6242.469390101847;5332.840014799563;5469.851331220449;5510.035743744868;5511.641743286674;5643.492085712305;6500.4799616030605;6576.634169729885;6763.932360676379;6796.932030679679;6932.296404402287;4244.3633454982;4643.489216186217;4645.558671926162;4648.837290694843;4653.534646535353;6800.217974932896;7236.710531578783;7249.383802376804;7254.600996945166;7263.6731347090035;3953.8616148435244;4577.473590537064;4709.929351059737;4717.78769955346;4727.149113159596;4810.95189048112;4839.540243676845;4843.75781210938;4848.200046992278;4849.078675051729;5601.131824567198;5607.467290607386;5615.775368985195;5615.887682246333;5620.887582248332;5665.631733937281;6877.312268773083;6884.173899132136;6897.3447522485285;6910.619915904674;1593.8007749031372;1682.503661419884;1685.2837544043732;1686.401327528734;1690.095798747664;1107.8061339265757;1116.4808364110727;1122.1135303110614;1125.3472985668293;1132.6035887439496;5338.3593968724;6586.506012049115;6598.736050557924;6598.769043083565;6601.70292336846;5771.365149833515;6134.570580059442;6846.5892046477375;7152.642367881689;7176.174739904874;5130.179171332569;6560.179977502812;6575.276719560845;6577.605343679299;6588.40704336612;3109.5646609474693;3673.68773654237;3810.7141964352786;3822.3310920588788;3837.5586807516934;7442.627868606548;7522.435817313723;7529.435292353095;7631.618419079024;7662.463627546018;7395.778126656209;7437.888431673529;7443.739469118555;7444.702211911571;7453.254674532612;6183.721732521957;7395.445341599401;7598.164201937782;7609.771706848804;7668.386529077548;7228.674709638184;7236.565806051653;7238.565686058853;7253.528520646141;7359.595222262613;7098.396636285974;7106.928930710834;7110;7117.928820711727;7142.142942846892;7369.299916507923;7590.0891892973195;7631.084269887649;7642.694292228249;7655.0813902332075;4621.260598304255;4650.465196502446;4677.111348843709;4679.555442232982;4687.367205427224;7183.784486465414;7229.710811567478;7235.204127546071;7241.674124664508;7244.311790379906;6705.8323541909895;6997.7200911962955;6999.12510936133;7000.929990700231;7007.159140903124;5587.7485513152815;6895.827604309932;6910.412614927586;6922.619255940972;6960.129983752031;6595.406413422815;6759.594424334556;6762.797116086525;6784.321567843176;6784.321567843176;6898.482613803884;6946.0622815919205;6953.895691564731;6958.234594194533;6962.477814163856;6771;6775.1531058617675;6786.966065169642;6810.182778066664;6819.624920629413 15:36:54 INFO - PROCESS | 1684 | |5;yui.html;677.6679427080732;681.2608319972833;691.8789211887919;736.8415790605019;752.7478294771249;14490.855091449082;14637.634059148513;14709.117452952816;14828.703425931488;15275.930684852065;12919.289439080847;12963.805542916863;12980.675483112927;12995.610131696041;13011.414486348114;842.1830824100628;859.6131740716703;860.9625401391309;862.8964524257098;865.8051938313891;716.6201912986126;725.600919494276;727.6616373386374;860.5095095795399;881.3169793410126;909.6770646420524;920.2637889688256;928.0811996123823;928.4290161550665;928.4429342394577;745.9254074592498;918.660095764568;922.2529750901791;922.529509949927;923.9260859131253;533.6371267538073;547.6029878338173;548.679022771679;616.7440512187437;680.6732768271257;14437;14460.710785784331;14487.710245795026;14503.782443263359;14507.854921450757;12404;12580.622581322576;12585.119041667087;13039.348032598427;13211.273379964097;9927.519661161865;9930.602775888956;10015.198784097254;10027.298089133763;10038.297319187659;3535.08087897146;3554.662307080823;3555.822208889545;3564;3567.839447224881;71352.2864771356;71933.640331798;74224.62887685528;74250;74330.25669743288;7946.7615971520945;9556.95221523888;9762.75593110178;9940.005999400002;10146;21466.78533214648;21467.463313416978;21486.24798132058;21669.91650417473;21975.780242197692;7636.08366995964;7658.885116723253;7772;7992.240737129963;8146.5519396433765;4104.343305071175;4186.162767446523;4193.958060419357;4196.097838964637;4198.475190601175;3592.1019745063736;3634.3821550336506;3634.618365071682;3635.8909232723063;3649.6532829381167;655.1188651264042;673.6800019990563;682.1677553384961;700.8458139209366;701.3512500936613;521.9817306394258;603.9456448919531;621.1273161208509;623.2645478335517;633.2780630081711;7121.679524421414;8932.374733768704;9030.051844556358;9074.364794464323;9347.345685801929;447.4585751241035;506.9264956581275;525.7686617888118;527.3829619345375;578.4822583787486;3923.725339226227;3975.7018223633345;3999.820053084347;4044.1507283470214;4348.934765978513;83584.58207709044;84221.57889210514;85208.14791852127;85232.14767852366;86524.7021294681;69266;69491.65254173697;69727.65136174287;75544.86682699763;75634.86547701679;69391.95912061323;69468.65265673639;70292.29707702858;70637.2936270641;70833.64583177051;8820.91179088201;8895.822083558422;8934.508602026692;8979.865302020344;9047.18860961145;48585.5141448581;48636.75681621569;49216.26175607297;49261.26108108453;49603.00793984172;45429.54570454385;65247;67427.52590770723;68620.62758744897;69333.65333173302;10554.525046373084;10658.253922225369;10744.30162039465;10930.45347732626;11613.767724645291;11614.303141811519;11757.588484403004;11967.521299147937;12141.15011949155;12404.25574465535;11245.550177993116;11488.770224595628;11506;11573.13201509907;11759.588414405454;11550.133739969704;11552.595659152226;11640.359780211831;11687.590934317259;11745.588904388305;7896.407769417202;10561.735956601147;11036.834447483134;11499;12072.45673944657;9490.335676502578;9524.093719071552;9545.61817527319;9596.760080997752;9601.739812612605;8600.913990860012;9069.67498260605;9631.662891798753;9641.228701703707;9828.459434731158 15:36:54 INFO - PROCESS | 1684 | __end_tp_report 15:36:54 INFO - PROCESS | 1684 | __start_cc_report 15:36:54 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1087 15:36:54 INFO - PROCESS | 1684 | __end_cc_report 15:36:54 INFO - PROCESS | 1684 | __startTimestamp1454110614637__endTimestamp 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | ------- Summary: start ------- 15:36:54 INFO - PROCESS | 1684 | Number of tests: 6 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5598.08 Median:5769.65 stddev:615.03 (10.7%) stddev-sans-first:592.61 15:36:54 INFO - PROCESS | 1684 | Values: 3415.7 3436.7 3456.3 3487.0 3512.9 5460.3 5508.4 5525.8 5544.8 5583.4 5505.6 5587.5 5593.4 5676.8 5691.2 5005.4 5065.6 5074.1 5094.1 5126.0 5106.5 5108.2 5109.7 5132.8 5148.5 5000.6 5065.1 5067.0 5081.8 5097.9 5075.2 5097.7 5101.2 5109.2 5121.4 4972.3 5045.6 5061.9 5062.3 5068.4 5364.8 5394.6 5398.2 5422.7 5453.5 6083.0 6089.8 6094.1 6110.3 6111.8 6082.2 6168.2 6168.8 6172.8 6180.0 5517.5 5567.8 5579.9 5618.2 5634.0 6167.0 6268.6 6276.5 6285.2 6308.9 5806.9 5967.9 5969.8 5988.2 5995.2 6024.0 6101.2 6132.3 6151.4 6167.2 5828.4 5887.6 5895.1 5908.3 5944.6 6069.2 6079.8 6104.1 6106.7 6114.6 4758.1 4811.2 4811.5 4812.7 4827.5 4282.6 4283.8 4323.5 4327.6 4336.9 5609.3 5635.7 5650.8 5662.3 5675.1 6068.7 6116.3 6158.6 6177.0 6181.4 5634.6 5634.8 5653.9 5723.6 5724.0 5244.5 5251.5 5266.1 5268.8 5298.0 6251.9 6258.1 6262.7 6263.0 6269.8 5522.6 5625.8 6085.8 6094.1 6105.1 6114.3 6273.7 6274.6 6275.8 6279.2 5988.9 6047.3 6051.0 6055.8 6107.7 6007.3 6123.3 6126.3 6130.5 6159.6 4697.5 5040.8 5769.7 5953.7 5958.5 5902.9 5923.1 5929.0 5936.2 5943.8 5630.5 5664.9 5820.5 5842.2 5853.4 5794.0 5840.9 5850.1 5883.4 5887.1 5747.0 5771.0 5773.0 5775.5 5784.5 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:63961.04 Median:36952.35 stddev:134952.24 (365.2%) stddev-sans-first:135246.53 15:36:54 INFO - PROCESS | 1684 | Values: 436.1 465.1 506.9 547.4 561.8 29746.8 36668.8 36918.4 36986.3 37003.8 41173.6 41493.8 41575.0 41620.6 41643.8 9524.8 9761.5 9767.0 9770.1 9789.4 9544.8 9681.7 9695.3 9710.5 9860.0 8478.8 9846.8 9870.1 9876.0 9878.2 9764.3 9801.4 9818.8 9831.9 9841.9 9696.0 9791.8 9819.5 9839.3 9842.5 39667.8 39910.0 40029.0 40050.0 40114.0 3079.2 3168.4 3234.0 3355.7 3582.7 27920.0 29024.1 29672.6 29706.6 29803.0 2713.0 2813.9 2832.0 2843.9 2885.3 480573.0 480694.0 481716.0 482924.0 483031.0 54316.5 55182.2 55229.0 61115.4 63832.0 60827.7 61161.7 61392.7 61707.0 61762.0 14890.2 16091.7 16250.8 16296.3 16329.8 11294.4 11324.0 12513.4 12760.5 13024.9 16463.8 17158.9 19014.4 19052.4 19095.5 6068.5 7832.2 7864.8 7903.0 7975.1 943.8 962.3 1066.1 1068.2 1070.6 26426.6 26444.2 26532.5 29415.0 30361.7 1068.3 1077.9 1085.1 1115.2 1135.6 13232.7 13417.3 13507.8 13530.9 13574.7 529183.0 537941.0 538608.0 539554.0 539878.0 55044.7 55414.0 55433.9 55508.2 55524.4 1408.6 1415.7 1432.1 1436.1 1444.4 26960.5 27167.3 27641.3 27659.6 27661.0 47807.8 48003.5 48110.8 48268.8 48284.0 492665.0 494974.0 502223.0 502891.0 505999.0 28687.7 29081.7 29089.7 29193.6 29297.9 40347.0 40919.0 40990.8 41402.6 42056.8 34893.8 35725.6 36176.8 36347.0 36537.5 35145.6 35870.8 36002.0 36189.5 36283.5 35255.8 35937.5 35953.3 36240.8 36303.5 30264.5 31984.5 32065.5 32068.0 32104.0 23410.8 23856.9 24288.0 24450.4 24461.6 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:37807.70 Median:365.29 stddev:126273.00 (34568.1%) stddev-sans-first:126595.86 15:36:54 INFO - PROCESS | 1684 | Values: 323.3 362.3 368.3 368.9 373.4 14756.9 15096.8 19461.9 20574.7 21085.4 15964.2 18899.5 19417.0 20095.6 20116.8 5595.3 5609.8 5768.5 5824.3 5828.2 4134.0 4355.4 4809.4 5793.6 5858.0 6162.3 6289.8 6305.0 6316.2 6316.4 6185.9 6274.3 6292.4 6296.5 6311.3 5299.5 5416.3 5428.9 5453.2 5459.2 21005.4 21129.8 23810.6 24853.6 24907.8 1957.5 2073.6 2075.8 2135.4 2196.8 9475.8 9502.4 9547.2 9730.1 9876.9 1680.8 1769.2 1770.3 1789.8 1821.5 91900.0 101650.5 101673.0 102050.0 103313.5 8929.4 10838.6 11012.9 11013.5 11102.9 12366.3 13223.3 13229.4 13251.8 13305.9 8181.5 8312.8 8367.9 8457.6 8457.8 7063.8 8540.3 8549.3 8576.0 8612.7 4187.0 4264.0 4275.4 4310.3 4313.6 1717.7 1771.5 1785.5 1788.7 1838.9 852.9 896.5 915.0 919.0 1040.9 17249.2 18586.3 18696.9 19330.0 20106.9 769.7 798.7 885.9 1001.5 1031.4 10083.0 10448.8 10461.9 10487.8 10573.7 759072.0 760656.0 761369.0 775786.0 779427.0 110961.0 116938.9 117331.0 119011.0 120929.0 1205.2 1205.3 1267.6 1285.0 1296.6 17046.8 17127.6 17132.3 17284.5 17543.6 46284.3 46526.1 47553.3 47616.5 48570.5 61908.0 64133.4 65202.7 65945.7 65974.0 7206.4 7324.7 7383.3 7499.3 7559.3 10422.5 11691.0 11853.6 11882.2 12003.5 7396.7 10496.8 10505.3 10510.8 10694.6 8697.9 9837.0 9917.5 10505.6 10580.5 8255.5 8735.9 10386.3 10849.0 10998.2 5677.4 7461.1 7583.0 7592.6 7622.4 9331.5 10442.4 10480.3 10619.4 10664.5 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:6045.46 Median:2872.74 stddev:3244.25 (112.9%) stddev-sans-first:3234.70 15:36:54 INFO - PROCESS | 1684 | Values: 1417.8 1553.2 1580.6 1839.7 1991.3 7910.1 8089.3 8505.4 8691.4 8696.8 8595.2 8612.4 8801.5 8802.1 8814.2 1998.4 2233.0 2343.5 2484.1 2508.1 2266.3 2270.3 2275.4 2276.0 2280.6 2291.2 2352.5 2358.4 2360.0 2362.6 2440.8 2472.0 2485.6 2486.4 2489.8 2104.1 2168.1 2171.7 2173.5 2481.9 7873.7 8305.6 8477.9 8525.4 8530.0 5224.6 5405.3 5410.9 5450.9 5461.4 3555.6 3617.5 3657.4 3670.0 3686.4 1052.1 1066.7 1071.6 1101.6 1102.8 11983.9 12051.5 12070.8 12112.3 12116.0 4851.8 4867.0 4945.2 4996.2 5038.1 10329.7 10330.3 10353.9 10355.6 10358.5 5507.8 5514.2 5536.2 5558.5 5562.8 4945.3 4993.9 5020.0 5030.2 5034.9 3784.6 3809.9 3828.1 3850.1 3874.6 1256.6 1263.9 1270.7 1272.1 1286.6 1331.4 1343.7 1365.5 1368.2 1371.1 7960.7 8151.1 8153.0 8172.4 8175.1 512.9 520.9 525.9 529.0 530.4 5809.6 5886.2 5983.2 6189.6 6205.4 10527.1 10727.4 10941.3 10995.7 11021.7 10591.4 10661.3 10668.1 10736.0 10737.7 6963.6 8232.1 8305.8 8397.9 8406.8 8101.1 8103.9 8104.4 8112.7 8154.6 9361.7 9502.1 9679.8 9844.3 9864.7 9744.0 10010.9 10011.5 10068.9 10209.3 7418.3 7473.6 7477.9 7484.0 7485.6 7942.6 8126.6 8144.9 8210.4 8225.9 7672.5 7707.7 7799.7 7844.0 7871.8 7325.5 7383.3 7485.2 7513.2 7537.5 7522.3 7567.2 7597.8 7654.5 7674.4 6909.6 6943.2 6948.9 6957.7 6971.5 6963.1 7001.0 7037.6 7045.1 7141.3 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:5655.54 Median:6422.78 stddev:1800.59 (28.0%) stddev-sans-first:1760.60 15:36:54 INFO - PROCESS | 1684 | Values: 323.4 331.6 335.0 337.5 340.5 6428.8 6452.6 6485.2 6491.8 6496.2 6386.2 6393.8 6414.0 6416.7 6460.2 4699.7 4848.8 4869.1 4877.3 4880.0 4485.0 4831.9 4852.9 4871.1 4874.9 3668.7 4269.8 4665.5 4797.5 4829.3 4555.5 4693.7 4711.2 4811.6 4821.9 4068.0 4136.5 4161.6 4164.7 4182.2 5205.7 6068.2 6232.8 6233.4 6242.5 5332.8 5469.9 5510.0 5511.6 5643.5 6500.5 6576.6 6763.9 6796.9 6932.3 4244.4 4643.5 4645.6 4648.8 4653.5 6800.2 7236.7 7249.4 7254.6 7263.7 3953.9 4577.5 4709.9 4717.8 4727.1 4811.0 4839.5 4843.8 4848.2 4849.1 5601.1 5607.5 5615.8 5615.9 5620.9 5665.6 6877.3 6884.2 6897.3 6910.6 1593.8 1682.5 1685.3 1686.4 1690.1 1107.8 1116.5 1122.1 1125.3 1132.6 5338.4 6586.5 6598.7 6598.8 6601.7 5771.4 6134.6 6846.6 7152.6 7176.2 5130.2 6560.2 6575.3 6577.6 6588.4 3109.6 3673.7 3810.7 3822.3 3837.6 7442.6 7522.4 7529.4 7631.6 7662.5 7395.8 7437.9 7443.7 7444.7 7453.3 6183.7 7395.4 7598.2 7609.8 7668.4 7228.7 7236.6 7238.6 7253.5 7359.6 7098.4 7106.9 7110.0 7117.9 7142.1 7369.3 7590.1 7631.1 7642.7 7655.1 4621.3 4650.5 4677.1 4679.6 4687.4 7183.8 7229.7 7235.2 7241.7 7244.3 6705.8 6997.7 6999.1 7000.9 7007.2 5587.7 6895.8 6910.4 6922.6 6960.1 6595.4 6759.6 6762.8 6784.3 6784.3 6898.5 6946.1 6953.9 6958.2 6962.5 6771.0 6775.2 6787.0 6810.2 6819.6 15:36:54 INFO - PROCESS | 1684 | 15:36:54 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:17543.55 Median:622.20 stddev:23993.35 (3856.2%) stddev-sans-first:24027.23 15:36:54 INFO - PROCESS | 1684 | Values: 677.7 681.3 691.9 736.8 752.7 14490.9 14637.6 14709.1 14828.7 15275.9 12919.3 12963.8 12980.7 12995.6 13011.4 842.2 859.6 861.0 862.9 865.8 716.6 725.6 727.7 860.5 881.3 909.7 920.3 928.1 928.4 928.4 745.9 918.7 922.3 922.5 923.9 533.6 547.6 548.7 616.7 680.7 14437.0 14460.7 14487.7 14503.8 14507.9 12404.0 12580.6 12585.1 13039.3 13211.3 9927.5 9930.6 10015.2 10027.3 10038.3 3535.1 3554.7 3555.8 3564.0 3567.8 71352.3 71933.6 74224.6 74250.0 74330.3 7946.8 9557.0 9762.8 9940.0 10146.0 21466.8 21467.5 21486.2 21669.9 21975.8 7636.1 7658.9 7772.0 7992.2 8146.6 4104.3 4186.2 4194.0 4196.1 4198.5 3592.1 3634.4 3634.6 3635.9 3649.7 655.1 673.7 682.2 700.8 701.4 522.0 603.9 621.1 623.3 633.3 7121.7 8932.4 9030.1 9074.4 9347.3 447.5 506.9 525.8 527.4 578.5 3923.7 3975.7 3999.8 4044.2 4348.9 83584.6 84221.6 85208.1 85232.1 86524.7 69266.0 69491.7 69727.7 75544.9 75634.9 69392.0 69468.7 70292.3 70637.3 70833.6 8820.9 8895.8 8934.5 8979.9 9047.2 48585.5 48636.8 49216.3 49261.3 49603.0 45429.5 65247.0 67427.5 68620.6 69333.7 10554.5 10658.3 10744.3 10930.5 11613.8 11614.3 11757.6 11967.5 12141.2 12404.3 11245.6 11488.8 11506.0 11573.1 11759.6 11550.1 11552.6 11640.4 11687.6 11745.6 7896.4 10561.7 11036.8 11499.0 12072.5 9490.3 9524.1 9545.6 9596.8 9601.7 8600.9 9069.7 9631.7 9641.2 9828.5 15:36:54 INFO - PROCESS | 1684 | -------- Summary: end -------- 15:36:54 INFO - PROCESS | 1684 | 15:36:55 INFO - TEST-INFO | 1684: exit 0 15:36:55 INFO - TEST-OK | dromaeo_css | took 1114127ms 15:36:55 INFO - TEST-START | kraken 15:36:55 INFO - operating with platform_type : mac_ 15:36:55 INFO - Initialising browser for kraken test... 15:36:55 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpGe78xa/profile http://localhost:49272/getInfo.html) 15:36:57 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 15:36:57 INFO - PROCESS | 1691 | colorDepth:24 15:36:57 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 15:36:57 INFO - PROCESS | 1691 | __metrics 15:36:57 INFO - PROCESS | 1691 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:36:57 INFO - PROCESS | 1691 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:36:57 INFO - PROCESS | 1691 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:58 INFO - TEST-INFO | 1691: exit 0 15:36:58 INFO - Browser initialized. 15:36:58 INFO - Running cycle 1/1 for kraken test... 15:36:58 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/2lld364j46g___08n54mb94h00000w/T/tmpGe78xa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:37:10 INFO - PROCESS | 1693 | RSS: Main: 243576832 15:37:10 INFO - PROCESS | 1693 | 15:37:12 INFO - PROCESS | 1693 | 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) 15:37:13 INFO - PROCESS | 1693 | RSS: Main: 290906112 15:37:13 INFO - PROCESS | 1693 | 15:37:16 INFO - PROCESS | 1693 | 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) 15:37:16 INFO - PROCESS | 1693 | RSS: Main: 300982272 15:37:16 INFO - PROCESS | 1693 | 15:37:19 INFO - PROCESS | 1693 | 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) 15:37:20 INFO - PROCESS | 1693 | RSS: Main: 288419840 15:37:20 INFO - PROCESS | 1693 | 15:37:22 INFO - PROCESS | 1693 | 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) 15:37:23 INFO - PROCESS | 1693 | RSS: Main: 289849344 15:37:23 INFO - PROCESS | 1693 | 15:37:25 INFO - PROCESS | 1693 | 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) 15:37:25 INFO - PROCESS | 1693 | RSS: Main: 291270656 15:37:25 INFO - PROCESS | 1693 | 15:37:28 INFO - PROCESS | 1693 | 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) 15:37:29 INFO - PROCESS | 1693 | RSS: Main: 292016128 15:37:29 INFO - PROCESS | 1693 | 15:37:31 INFO - PROCESS | 1693 | 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) 15:37:32 INFO - PROCESS | 1693 | RSS: Main: 293212160 15:37:32 INFO - PROCESS | 1693 | 15:37:35 INFO - PROCESS | 1693 | 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) 15:37:35 INFO - PROCESS | 1693 | RSS: Main: 293380096 15:37:35 INFO - PROCESS | 1693 | 15:37:37 INFO - PROCESS | 1693 | 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) 15:37:37 INFO - PROCESS | 1693 | RSS: Main: 323878912 15:37:37 INFO - PROCESS | 1693 | 15:37:39 INFO - PROCESS | 1693 | 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) 15:37:40 INFO - PROCESS | 1693 | RSS: Main: 325312512 15:37:40 INFO - PROCESS | 1693 | 15:37:42 INFO - PROCESS | 1693 | 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) 15:37:42 INFO - PROCESS | 1693 | RSS: Main: 332988416 15:37:42 INFO - PROCESS | 1693 | 15:37:45 INFO - PROCESS | 1693 | 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) 15:37:45 INFO - PROCESS | 1693 | RSS: Main: 333725696 15:37:45 INFO - PROCESS | 1693 | 15:37:48 INFO - PROCESS | 1693 | 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) 15:37:48 INFO - PROCESS | 1693 | RSS: Main: 334249984 15:37:48 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | 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) 15:37:50 INFO - PROCESS | 1693 | RSS: Main: 395010048 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | __start_tp_report 15:37:50 INFO - PROCESS | 1693 | _x_x_mozilla_page_load 15:37:50 INFO - PROCESS | 1693 | _x_x_mozilla_page_load_details 15:37:50 INFO - PROCESS | 1693 | |i|pagename|runs| 15:37:50 INFO - PROCESS | 1693 | |0;ai-astar;148;154;143;112;110;110;115;111;110;109 15:37:50 INFO - PROCESS | 1693 | |1;audio-beat-detection;149;118;140;151;117;144;160;126;155;118 15:37:50 INFO - PROCESS | 1693 | |2;audio-dft;183;181;183;186;185;179;185;183;180;183 15:37:50 INFO - PROCESS | 1693 | |3;audio-fft;75;80;82;80;77;82;77;95;74;57 15:37:50 INFO - PROCESS | 1693 | |4;audio-oscillator;92;95;124;78;79;81;111;75;77;104 15:37:50 INFO - PROCESS | 1693 | |5;imaging-gaussian-blur;87;92;84;90;85;90;84;91;84;90 15:37:50 INFO - PROCESS | 1693 | |6;imaging-darkroom;93;93;94;92;92;92;91;95;94;92 15:37:50 INFO - PROCESS | 1693 | |7;imaging-desaturate;87;86;88;85;87;84;86;87;84;84 15:37:50 INFO - PROCESS | 1693 | |8;json-parse-financial;55;56;55;53;54;53;53;63;52;52 15:37:50 INFO - PROCESS | 1693 | |9;json-stringify-tinderbox;63;62;70;76;72;68;68;66;66;67 15:37:50 INFO - PROCESS | 1693 | |10;stanford-crypto-aes;83;83;82;82;82;81;83;82;84;84 15:37:50 INFO - PROCESS | 1693 | |11;stanford-crypto-ccm;121;121;124;124;123;123;122;130;117;115 15:37:50 INFO - PROCESS | 1693 | |12;stanford-crypto-pbkdf2;137;135;135;136;136;135;136;135;132;155 15:37:50 INFO - PROCESS | 1693 | |13;stanford-crypto-sha256-iterative;69;66;69;67;67;66;66;67;65;82 15:37:50 INFO - PROCESS | 1693 | __end_tp_report 15:37:50 INFO - PROCESS | 1693 | __start_cc_report 15:37:50 INFO - PROCESS | 1693 | _x_x_mozilla_cycle_collect,1135 15:37:50 INFO - PROCESS | 1693 | __end_cc_report 15:37:50 INFO - PROCESS | 1693 | __startTimestamp1454110670886__endTimestamp 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | ------- Summary: start ------- 15:37:50 INFO - PROCESS | 1693 | Number of tests: 14 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#0] ai-astar Cycles:10 Average:122.20 Median:113.50 stddev:18.29 (16.1%) stddev-sans-first:16.85 15:37:50 INFO - PROCESS | 1693 | Values: 148.0 154.0 143.0 112.0 110.0 110.0 115.0 111.0 110.0 109.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:146.50 stddev:16.63 (11.3%) stddev-sans-first:17.13 15:37:50 INFO - PROCESS | 1693 | Values: 149.0 118.0 140.0 151.0 117.0 144.0 160.0 126.0 155.0 118.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#2] audio-dft Cycles:10 Average:182.80 Median:183.00 stddev:2.25 (1.2%) stddev-sans-first:2.39 15:37:50 INFO - PROCESS | 1693 | Values: 183.0 181.0 183.0 186.0 185.0 179.0 185.0 183.0 180.0 183.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#3] audio-fft Cycles:10 Average:77.90 Median:80.00 stddev:9.41 (11.8%) stddev-sans-first:9.92 15:37:50 INFO - PROCESS | 1693 | Values: 75.0 80.0 82.0 80.0 77.0 82.0 77.0 95.0 74.0 57.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:78.50 stddev:16.79 (21.4%) stddev-sans-first:17.81 15:37:50 INFO - PROCESS | 1693 | Values: 92.0 95.0 124.0 78.0 79.0 81.0 111.0 75.0 77.0 104.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:90.00 stddev:3.23 (3.6%) stddev-sans-first:3.42 15:37:50 INFO - PROCESS | 1693 | Values: 87.0 92.0 84.0 90.0 85.0 90.0 84.0 91.0 84.0 90.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:1.23 (1.3%) stddev-sans-first:1.30 15:37:50 INFO - PROCESS | 1693 | Values: 93.0 93.0 94.0 92.0 92.0 92.0 91.0 95.0 94.0 92.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.50 stddev:1.48 (1.7%) stddev-sans-first:1.50 15:37:50 INFO - PROCESS | 1693 | Values: 87.0 86.0 88.0 85.0 87.0 84.0 86.0 87.0 84.0 84.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:3.24 (5.9%) stddev-sans-first:3.43 15:37:50 INFO - PROCESS | 1693 | Values: 55.0 56.0 55.0 53.0 54.0 53.0 53.0 63.0 52.0 52.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:4.13 (6.1%) stddev-sans-first:4.00 15:37:50 INFO - PROCESS | 1693 | Values: 63.0 62.0 70.0 76.0 72.0 68.0 68.0 66.0 66.0 67.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 15:37:50 INFO - PROCESS | 1693 | Values: 83.0 83.0 82.0 82.0 82.0 81.0 83.0 82.0 84.0 84.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:123.00 stddev:4.08 (3.3%) stddev-sans-first:4.31 15:37:50 INFO - PROCESS | 1693 | Values: 121.0 121.0 124.0 124.0 123.0 123.0 122.0 130.0 117.0 115.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:137.20 Median:136.00 stddev:6.39 (4.7%) stddev-sans-first:6.78 15:37:50 INFO - PROCESS | 1693 | Values: 137.0 135.0 135.0 136.0 136.0 135.0 136.0 135.0 132.0 155.0 15:37:50 INFO - PROCESS | 1693 | 15:37:50 INFO - PROCESS | 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:67.00 stddev:4.95 (7.4%) stddev-sans-first:5.24 15:37:50 INFO - PROCESS | 1693 | Values: 69.0 66.0 69.0 67.0 67.0 66.0 66.0 67.0 65.0 82.0 15:37:50 INFO - PROCESS | 1693 | -------- Summary: end -------- 15:37:50 INFO - PROCESS | 1693 | 15:37:51 INFO - TEST-INFO | 1693: exit 0 15:37:51 INFO - TEST-OK | kraken | took 56323ms 15:37:51 INFO - SUITE-END | took 1170s 15:37:52 INFO - Completed test suite (00:19:30) 15:37:52 INFO - Working with test: dromaeo_css 15:37:52 INFO - Generating results file: dromaeo_css 15:37:52 INFO - Working with test: kraken 15:37:52 INFO - Generating results file: kraken 15:37:52 INFO - javascript benchmark 15:37:52 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:37:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 15:37:52 INFO - process_Request line: dromaeo_css 7365.44 graph.html#tests=[[72,1,59]] 15:37:52 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:37:52 INFO - process_Request line: kraken 1411.20 graph.html#tests=[[232,1,59]] 15:37:52 INFO - RETURN: dromaeo_css: 7365.44 15:37:52 INFO - RETURN: kraken: 1411.20 15:37:52 INFO - javascript benchmark 15:37:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3415.6584341565845, 3436.7078798302127, 3456.3087382523486, 3487.0062032320793, 3512.8770493032735, 5460.262864513289, 5508.39407665157, 5525.751341189646, 5544.77820887164, 5583.441655834425, 5505.642133261335, 5587.469190426903, 5593.384727679962, 5676.772929082842, 5691.231683722696, 5005.399352077756, 5065.594752419806, 5074.086664400406, 5094.1085310070775, 5126.000429916168, 5106.489351064901, 5108.20822772469, 5109.744512774365, 5132.769025393866, 5148.536631703146, 5000.599952003831, 5065.088284108877, 5067.01193267313, 5081.79672813087, 5097.949020509822, 5075.238714192864, 5097.745112744385, 5101.15830887903, 5109.182530795092, 5121.436641969381, 4972.303877457159, 5045.621578381636, 5061.898762024775, 5062.31658726071, 5068.366454193226, 5364.839054828361, 5394.568434525228, 5398.24424580559, 5422.701751403672, 5453.481919217668, 6082.96958515209, 6089.804395363034, 6094.146819445237, 6110.29731580865, 6111.755529778803, 6082.209312789353, 6168.167297414837, 6168.845778855564, 6172.814815555541, 6180.0, 5517.531009864167, 5567.805126820583, 5579.888402231933, 5618.213450116987, 5633.971830140823, 6166.969165154235, 6268.561200715906, 6276.466500347522, 6285.182926219562, 6308.905366419507, 5806.854828629233, 5967.880642387128, 5969.76120955157, 5988.221531201003, 5995.160677505153, 6024.036154215392, 6101.247350682792, 6132.294786099566, 6151.446369826737, 6167.229096362955, 5828.388019257917, 5887.61730487517, 5895.086261629454, 5908.261467316585, 5944.583879128506, 6069.15031895535, 6079.848003799941, 6104.145419641254, 6106.664133472702, 6114.57197996136, 4758.119747846659, 4811.158047341772, 4811.49479304675, 4812.663113582085, 4827.468978412372, 4282.571742825692, 4283.828646854154, 4323.459567554056, 4327.6321512671775, 4336.934945975813, 5609.298837645294, 5635.746391412396, 5650.830475085754, 5662.320521537442, 5675.091985282335, 6068.666223357669, 6116.296625887991, 6158.599691020069, 6176.969115154486, 6181.381861813783, 5634.6337488063145, 5634.802781902614, 5653.858653533694, 5723.570732195102, 5724.026915424388, 5244.501772331622, 5251.474852514718, 5266.078436273637, 5268.841934741964, 5298.0, 6251.906221406683, 6258.061290806416, 6262.749490020348, 6262.968685156545, 6269.81190564293, 5522.558195344443, 5625.774969001194, 6085.817425477243, 6094.116353128683, 6105.114758359924, 6114.297368145999, 6273.686315684289, 6274.560780745304, 6275.843103922439, 6279.215098112736, 5988.910166347421, 6047.312553656988, 6051.0, 6055.7577696893395, 6107.69461526913, 6007.30915944672, 6123.309763056693, 6126.326104128631, 6130.5402094842175, 6159.5688301818445, 4697.483276839614, 5040.798368065236, 5769.653820770767, 5953.6725480097275, 5958.463738263404, 5902.940970590239, 5923.052311630118, 5929.0, 5936.1986131871645, 5943.762249509971, 5630.465105814941, 5664.85837854057, 5820.534357251495, 5842.211301474416, 5853.414658534112, 5794.0439827428, 5840.912386314124, 5850.12248162779, 5883.411658834082, 5887.146363777314, 5747.0, 5771.047777116896, 5773.0, 5775.451332123442, 5784.4504772046585], "unit": "score", "name": "dojo.html", "value": 5560.5427498795125}, {"lowerIsBetter": false, "replicates": [436.08422313142404, 465.07218099890724, 506.8606133313338, 547.4252035362871, 561.8033688209126, 29746.835443037966, 36668.816655916715, 36918.44622330667, 36986.26027479449, 37003.81498092506, 41173.58826411735, 41493.792531037376, 41575.0, 41620.58379416205, 41643.79178104105, 9524.809503809936, 9761.463119528424, 9766.951165244163, 9770.071843174886, 9789.412635241908, 9544.809103817954, 9681.709548713514, 9695.272854535939, 9710.465924374157, 9859.950700246489, 8478.78803029923, 9846.803063938753, 9870.062344077302, 9876.0, 9878.221920054388, 9764.316497845119, 9801.362911410735, 9818.803623927553, 9831.901680983241, 9841.852372214422, 9696.0, 9791.755206119833, 9819.509024548744, 9839.262055345878, 9842.458664773434, 39667.809965701075, 39910.0, 40029.0, 40050.0, 40113.99715007119, 3079.245584831708, 3168.429682657121, 3234.0, 3355.7147642450423, 3582.659647333499, 27920.0, 29024.129276121752, 29672.554911676343, 29706.554401683992, 29803.0, 2712.972870271292, 2813.9296517587018, 2831.9716802831913, 2843.8720257588457, 2885.264257614295, 480573.0, 480694.0, 481716.0, 482924.0, 483031.0, 54316.45683543193, 55182.17226741602, 55229.0, 61115.38884611186, 63832.0, 60827.695861520406, 61161.69419152876, 61392.69303653453, 61707.0, 61762.0, 14890.181040042686, 16091.67816643684, 16250.781191410691, 16296.34814607426, 16329.755053674204, 11294.435278236055, 11323.980841724284, 12513.436895339732, 12760.532538757976, 13024.869751302555, 16463.83536164623, 17158.88467249625, 19014.42956711301, 19052.428427147206, 19095.52261193481, 6068.514518838482, 7832.216778322122, 7864.803379915548, 7902.960485197537, 7975.082865470546, 943.8112377524523, 962.31675510387, 1066.0778426661038, 1068.2041878800187, 1070.6252811515908, 26426.603600946, 26444.206673799432, 26532.469350613264, 29415.0, 30361.696383036327, 1068.289587424354, 1077.9191560632985, 1085.0776839686202, 1115.1914861725184, 1135.5514571744116, 13232.669183270302, 13417.329133543284, 13507.797383039262, 13530.93234533821, 13574.728505429835, 529183.0, 537941.0, 538608.0, 539554.0, 539878.0, 55044.724776375864, 55414.0, 55433.89132217333, 55508.16737748937, 55524.44475555274, 1408.5774267719644, 1415.7310111078862, 1432.0834665814095, 1436.0665567381286, 1444.3534370817276, 26960.460790783683, 27167.320816979733, 27641.308967275978, 27659.58510622302, 27661.0, 47807.76096119636, 48003.5199647999, 48110.759446202544, 48268.79328016687, 48284.03431931271, 492665.0, 494974.0, 502223.0, 502891.0, 505999.0, 28687.71312286934, 29081.709182908748, 29089.7091029087, 29193.562096568992, 29297.85351073231, 40347.0, 40919.0, 40990.79504602458, 41402.585974141075, 42056.78971605122, 34893.8255308732, 35725.64274357223, 36176.819115904254, 36347.0, 36537.451938220416, 35145.64854351424, 35870.8206458966, 36002.01988890636, 36189.457158143174, 36283.45574816327, 35255.82372088123, 35937.46093808542, 35953.28093438169, 36240.81879590585, 36303.455448168825, 30264.54603180998, 31984.52023219607, 32065.51901721523, 32068.0, 32104.0, 23410.76589234086, 23856.92643830997, 24287.975076027273, 24450.388740281636, 24461.633075504236], "unit": "score", "name": "ext.html", "value": 19201.258424102452}, {"lowerIsBetter": false, "replicates": [323.256510026938, 362.2736413490951, 368.30206758193214, 368.9003968928391, 373.3745975491054, 14756.852431475681, 15096.773548396783, 19461.902690486546, 20574.691379629297, 21085.367438976817, 15964.201789910487, 18899.52751181221, 19417.0, 20095.59808803823, 20116.798832011675, 5595.300587426572, 5609.831705048855, 5768.480836724694, 5824.301083869942, 5828.154917536955, 4133.979330103345, 4355.412019377391, 4809.374781278429, 5793.594448388614, 5858.0, 6162.322144564095, 6289.842753931165, 6305.022721478178, 6316.1788967434395, 6316.399942005502, 6185.938140618581, 6274.341194174637, 6292.402221788922, 6296.464800491964, 6311.305756366796, 5299.4700529946695, 5416.295881535375, 5428.891422171574, 5453.15476101201, 5459.181122831607, 21005.36983890486, 21129.788702112935, 23810.64284035741, 24853.627195592082, 24907.750922490904, 1957.4910523263911, 2073.6163809695254, 2075.813176814079, 2135.3807395855183, 2196.846220764547, 9475.810483790285, 9502.4298542087, 9547.188488978445, 9730.12428881404, 9876.851847222297, 1680.7983042035034, 1769.195016267595, 1770.2918832466987, 1789.7852257729025, 1821.4754946848743, 91900.0, 101650.49174754079, 101673.0, 102049.99999999926, 103313.48343258236, 8929.374943754005, 10838.615504588977, 11012.944935275433, 11013.504392302366, 11102.888971110347, 12366.319852408204, 13223.272720000492, 13229.404676789567, 13251.801222981663, 13305.933470332586, 8181.509109453452, 8312.792180195422, 8367.874481882776, 8457.619407126695, 8457.788555286166, 7063.82340441493, 8540.27407670355, 8549.316054715608, 8576.013758417861, 8612.741617751477, 4186.979065104655, 4263.957360426418, 4275.358696195595, 4310.267254566731, 4313.568643135662, 1717.7079896417638, 1771.4685594321652, 1785.4554360920044, 1788.7227479740661, 1838.9448316550258, 852.9147085291545, 896.4710820615737, 915.0437792506714, 918.995405022984, 1040.9063184313447, 17249.22378492971, 18586.25654973786, 18696.906515467337, 19330.0, 20106.899465502578, 769.7305942920045, 798.66456088443, 885.8793626063035, 1001.4942454060798, 1031.3554028732042, 10083.042110999444, 10448.843267350996, 10461.895381046244, 10487.842682359771, 10573.735656608493, 759072.0, 760656.0, 761369.0, 775786.0, 779427.0, 110961.0, 116938.94672047728, 117331.0, 119011.0, 120929.0, 1205.2166092040068, 1205.3069485046133, 1267.5563552756646, 1284.9614511564669, 1296.572131196703, 17046.82953170502, 17127.571810704332, 17132.314707411562, 17284.481465556055, 17543.649127017132, 46284.305735414666, 46526.069478610916, 47553.28670069882, 47616.52383476121, 48570.51429485801, 61908.0, 64133.358666412736, 65202.673986631664, 65945.67027164834, 65974.0, 7206.423486121203, 7324.7070117196845, 7383.335499805044, 7499.287567681062, 7559.3196612305155, 10422.478876056015, 11691.0, 11853.5851245206, 11882.16824822254, 12003.519859205533, 7396.704131834666, 10496.842547361948, 10505.31715438494, 10510.842337364793, 10694.62568810088, 8697.91302086971, 9836.950815245878, 9917.512373143798, 10505.579776808841, 10580.470976450993, 8255.504669719836, 8735.868961965703, 10386.323598739427, 10849.0, 10998.230123891251, 5677.3754886963225, 7461.141968673672, 7583.014208152905, 7592.582407967615, 7622.352100071556, 9331.486768227813, 10442.373457592568, 10480.266381353536, 10619.36283822973, 10664.46677666098], "unit": "score", "name": "jquery.html", "value": 9042.306310261427}, {"lowerIsBetter": false, "replicates": [1417.8227721534809, 1553.2466753624492, 1580.596947778316, 1839.7240413937907, 1991.332903477335, 7910.129885712574, 8089.271965523102, 8505.362097842662, 8691.39160258782, 8696.826063478742, 8595.18345757152, 8612.39713220075, 8801.515916624583, 8802.07578204289, 8814.206721395074, 1998.4004798560447, 2233.0286325448483, 2343.5078633486987, 2484.1305543059966, 2508.147229941819, 2266.286119872243, 2270.330252575486, 2275.3742720751843, 2275.9658605120935, 2280.5894938910988, 2291.209532711212, 2352.494213744045, 2358.422186564294, 2360.0205914545445, 2362.621980483123, 2440.804735621155, 2472.0235506974736, 2485.6395822605623, 2486.415692312305, 2489.788367988723, 2104.0531760707745, 2168.0677308757226, 2171.695962565242, 2173.5326904715403, 2481.9131330403347, 7873.724419645342, 8305.584720763998, 8477.872831907527, 8525.403221774479, 8530.0, 5224.555912747421, 5405.324334458192, 5410.91883621746, 5450.945490545123, 5461.42655021225, 3555.6088830228655, 3617.5116359291424, 3657.414813629833, 3670.0, 3686.3548878946076, 1052.1319911073394, 1066.6799960011965, 1071.560660129351, 1101.6474728087014, 1102.8345748137763, 11983.880161198364, 12051.517939282418, 12070.758584828254, 12112.333821639806, 12116.0, 4851.840930785766, 4866.95133048665, 4945.208766597327, 4996.225585034253, 5038.0931432341795, 10329.690109296733, 10330.276880618434, 10353.948230258951, 10355.585776569003, 10358.53386597605, 5507.779688812403, 5514.228008078872, 5536.2249285100115, 5558.499735023786, 5562.833115006556, 4945.258211268267, 4993.90012199754, 5019.996000799854, 5030.245463180479, 5034.874128146753, 3784.6026167252594, 3809.8666546670734, 3828.1386687994977, 3850.114473671071, 3874.593167717349, 1256.58532684214, 1263.911526193176, 1270.656922630903, 1272.0904553244475, 1286.5754301080622, 1331.4474493085454, 1343.657367371314, 1365.528892532075, 1368.213277365499, 1371.136184203945, 7960.681572737141, 8151.062627797761, 8153.0, 8172.42793004484, 8175.1416101308505, 512.8769095417073, 520.9270702101709, 525.90796610593, 528.9735513224323, 530.3794560364383, 5809.564282678816, 5886.175935369051, 5983.1623572699855, 6189.597676151036, 6205.379462053849, 10527.052565269163, 10727.356358618508, 10941.343519388862, 10995.670129896116, 11021.669349919515, 10591.364518128938, 10661.307015043998, 10668.093212077061, 10736.033756961911, 10737.711474623095, 6963.582185068912, 8232.053313868862, 8305.750827475305, 8397.874031889527, 8406.789830254293, 8101.10887802353, 8103.918960810553, 8104.432689711663, 8112.675492980215, 8154.592270386338, 9361.719148425558, 9502.097300756417, 9679.806403871742, 9844.310898237054, 9864.654737084167, 9743.951280243553, 10010.948850370607, 10011.54948027326, 10068.89931100709, 10209.285350025724, 7418.295261950106, 7473.626318683935, 7477.925220747723, 7483.962580187064, 7485.625718714152, 7942.563159026309, 8126.634301456331, 8144.918550814416, 8210.425270231026, 8225.876611850706, 7672.5012874163, 7707.730229441942, 7799.688012479437, 7844.0, 7871.803204919923, 7325.4872158948365, 7383.2985866342615, 7485.1766305707415, 7513.248675132443, 7537.54774713519, 7522.322990930624, 7567.243275672609, 7597.810054748676, 7654.464187506821, 7674.386049116169, 6909.585424874524, 6943.236244013256, 6948.861022779617, 6957.686904089227, 6971.477139214478, 6963.059986901703, 7000.964995174992, 7037.577745335297, 7045.084139061889, 7141.285871413025], "unit": "score", "name": "mootools.html", "value": 4825.726202001226}, {"lowerIsBetter": false, "replicates": [323.4049349197477, 331.5739275031585, 335.0150557361356, 337.46680245212565, 340.5113661895179, 6428.807135785928, 6452.58058226215, 6485.156929599151, 6491.805245842632, 6496.187976502937, 6386.233651961771, 6393.808185754435, 6413.967930160355, 6416.743330266795, 6460.192475940507, 4699.718016918979, 4848.806047758086, 4869.123557759593, 4877.317175595419, 4879.975600121995, 4485.035717320776, 4831.855044348676, 4852.878678033042, 4871.098846713352, 4874.902501949959, 3668.724845636588, 4269.829206831723, 4665.486796452387, 4797.544233297831, 4829.348038014876, 4555.498895121534, 4693.671442998992, 4711.151992641323, 4811.615070794345, 4821.855344339693, 4067.959320406788, 4136.544980052192, 4161.646260067898, 4164.708470407073, 4182.247195504808, 5205.687658740488, 6068.241469816273, 6232.844178895519, 6233.376662333776, 6242.469390101847, 5332.840014799563, 5469.851331220449, 5510.035743744868, 5511.641743286674, 5643.492085712305, 6500.4799616030605, 6576.634169729885, 6763.932360676379, 6796.932030679679, 6932.296404402287, 4244.3633454982, 4643.489216186217, 4645.558671926162, 4648.837290694843, 4653.534646535353, 6800.217974932896, 7236.710531578783, 7249.383802376804, 7254.600996945166, 7263.6731347090035, 3953.8616148435244, 4577.473590537064, 4709.929351059737, 4717.78769955346, 4727.149113159596, 4810.95189048112, 4839.540243676845, 4843.75781210938, 4848.200046992278, 4849.078675051729, 5601.131824567198, 5607.467290607386, 5615.775368985195, 5615.887682246333, 5620.887582248332, 5665.631733937281, 6877.312268773083, 6884.173899132136, 6897.3447522485285, 6910.619915904674, 1593.8007749031372, 1682.503661419884, 1685.2837544043732, 1686.401327528734, 1690.095798747664, 1107.8061339265757, 1116.4808364110727, 1122.1135303110614, 1125.3472985668293, 1132.6035887439496, 5338.3593968724, 6586.506012049115, 6598.736050557924, 6598.769043083565, 6601.70292336846, 5771.365149833515, 6134.570580059442, 6846.5892046477375, 7152.642367881689, 7176.174739904874, 5130.179171332569, 6560.179977502812, 6575.276719560845, 6577.605343679299, 6588.40704336612, 3109.5646609474693, 3673.68773654237, 3810.7141964352786, 3822.3310920588788, 3837.5586807516934, 7442.627868606548, 7522.435817313723, 7529.435292353095, 7631.618419079024, 7662.463627546018, 7395.778126656209, 7437.888431673529, 7443.739469118555, 7444.702211911571, 7453.254674532612, 6183.721732521957, 7395.445341599401, 7598.164201937782, 7609.771706848804, 7668.386529077548, 7228.674709638184, 7236.565806051653, 7238.565686058853, 7253.528520646141, 7359.595222262613, 7098.396636285974, 7106.928930710834, 7110.0, 7117.928820711727, 7142.142942846892, 7369.299916507923, 7590.0891892973195, 7631.084269887649, 7642.694292228249, 7655.0813902332075, 4621.260598304255, 4650.465196502446, 4677.111348843709, 4679.555442232982, 4687.367205427224, 7183.784486465414, 7229.710811567478, 7235.204127546071, 7241.674124664508, 7244.311790379906, 6705.8323541909895, 6997.7200911962955, 6999.12510936133, 7000.929990700231, 7007.159140903124, 5587.7485513152815, 6895.827604309932, 6910.412614927586, 6922.619255940972, 6960.129983752031, 6595.406413422815, 6759.594424334556, 6762.797116086525, 6784.321567843176, 6784.321567843176, 6898.482613803884, 6946.0622815919205, 6953.895691564731, 6958.234594194533, 6962.477814163856, 6771.0, 6775.1531058617675, 6786.966065169642, 6810.182778066664, 6819.624920629413], "unit": "score", "name": "prototype.html", "value": 5067.849494828402}, {"lowerIsBetter": false, "replicates": [677.6679427080732, 681.2608319972833, 691.8789211887919, 736.8415790605019, 752.7478294771249, 14490.855091449082, 14637.634059148513, 14709.117452952816, 14828.703425931488, 15275.930684852065, 12919.289439080847, 12963.805542916863, 12980.675483112927, 12995.610131696041, 13011.414486348114, 842.1830824100628, 859.6131740716703, 860.9625401391309, 862.8964524257098, 865.8051938313891, 716.6201912986126, 725.600919494276, 727.6616373386374, 860.5095095795399, 881.3169793410126, 909.6770646420524, 920.2637889688256, 928.0811996123823, 928.4290161550665, 928.4429342394577, 745.9254074592498, 918.660095764568, 922.2529750901791, 922.529509949927, 923.9260859131253, 533.6371267538073, 547.6029878338173, 548.679022771679, 616.7440512187437, 680.6732768271257, 14437.0, 14460.710785784331, 14487.710245795026, 14503.782443263359, 14507.854921450757, 12404.0, 12580.622581322576, 12585.119041667087, 13039.348032598427, 13211.273379964097, 9927.519661161865, 9930.602775888956, 10015.198784097254, 10027.298089133763, 10038.297319187659, 3535.08087897146, 3554.662307080823, 3555.822208889545, 3564.0, 3567.839447224881, 71352.2864771356, 71933.640331798, 74224.62887685528, 74250.0, 74330.25669743288, 7946.7615971520945, 9556.95221523888, 9762.75593110178, 9940.005999400002, 10146.0, 21466.78533214648, 21467.463313416978, 21486.24798132058, 21669.91650417473, 21975.780242197692, 7636.08366995964, 7658.885116723253, 7772.0, 7992.240737129963, 8146.5519396433765, 4104.343305071175, 4186.162767446523, 4193.958060419357, 4196.097838964637, 4198.475190601175, 3592.1019745063736, 3634.3821550336506, 3634.618365071682, 3635.8909232723063, 3649.6532829381167, 655.1188651264042, 673.6800019990563, 682.1677553384961, 700.8458139209366, 701.3512500936613, 521.9817306394258, 603.9456448919531, 621.1273161208509, 623.2645478335517, 633.2780630081711, 7121.679524421414, 8932.374733768704, 9030.051844556358, 9074.364794464323, 9347.345685801929, 447.4585751241035, 506.9264956581275, 525.7686617888118, 527.3829619345375, 578.4822583787486, 3923.725339226227, 3975.7018223633345, 3999.820053084347, 4044.1507283470214, 4348.934765978513, 83584.58207709044, 84221.57889210514, 85208.14791852127, 85232.14767852366, 86524.7021294681, 69266.0, 69491.65254173697, 69727.65136174287, 75544.86682699763, 75634.86547701679, 69391.95912061323, 69468.65265673639, 70292.29707702858, 70637.2936270641, 70833.64583177051, 8820.91179088201, 8895.822083558422, 8934.508602026692, 8979.865302020344, 9047.18860961145, 48585.5141448581, 48636.75681621569, 49216.26175607297, 49261.26108108453, 49603.00793984172, 45429.54570454385, 65247.0, 67427.52590770723, 68620.62758744897, 69333.65333173302, 10554.525046373084, 10658.253922225369, 10744.30162039465, 10930.45347732626, 11613.767724645291, 11614.303141811519, 11757.588484403004, 11967.521299147937, 12141.15011949155, 12404.25574465535, 11245.550177993116, 11488.770224595628, 11506.0, 11573.13201509907, 11759.588414405454, 11550.133739969704, 11552.595659152226, 11640.359780211831, 11687.590934317259, 11745.588904388305, 7896.407769417202, 10561.735956601147, 11036.834447483134, 11499.0, 12072.45673944657, 9490.335676502578, 9524.093719071552, 9545.61817527319, 9596.760080997752, 9601.739812612605, 8600.913990860012, 9069.67498260605, 9631.662891798753, 9641.228701703707, 9828.459434731158], "unit": "score", "name": "yui.html", "value": 6761.5273338179895}], "name": "dromaeo_css", "value": 7365.439971553303}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [148.0, 154.0, 143.0, 112.0, 110.0, 110.0, 115.0, 111.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 122.2}, {"lowerIsBetter": true, "replicates": [149.0, 118.0, 140.0, 151.0, 117.0, 144.0, 160.0, 126.0, 155.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 137.8}, {"lowerIsBetter": true, "replicates": [183.0, 181.0, 183.0, 186.0, 185.0, 179.0, 185.0, 183.0, 180.0, 183.0], "unit": "score", "name": "audio-dft", "value": 182.8}, {"lowerIsBetter": true, "replicates": [75.0, 80.0, 82.0, 80.0, 77.0, 82.0, 77.0, 95.0, 74.0, 57.0], "unit": "score", "name": "audio-fft", "value": 77.9}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 124.0, 78.0, 79.0, 81.0, 111.0, 75.0, 77.0, 104.0], "unit": "score", "name": "audio-oscillator", "value": 91.6}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 84.0, 90.0, 85.0, 90.0, 84.0, 91.0, 84.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 92.0, 92.0, 92.0, 91.0, 95.0, 94.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.8}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 88.0, 85.0, 87.0, 84.0, 86.0, 87.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 53.0, 54.0, 53.0, 53.0, 63.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 70.0, 76.0, 72.0, 68.0, 68.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 83.0, 82.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [121.0, 121.0, 124.0, 124.0, 123.0, 123.0, 122.0, 130.0, 117.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [137.0, 135.0, 135.0, 136.0, 136.0, 135.0, 136.0, 135.0, 132.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 137.2}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 69.0, 67.0, 67.0, 66.0, 66.0, 67.0, 65.0, 82.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1411.2}]} 15:37:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1411.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7365.44"}}} 15:37:52 INFO - Return code: 0 15:37:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:37:52 INFO - # TBPL SUCCESS # 15:37:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:37:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:37:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:37:52 INFO - 2016-01-29 15:37:52.274 screenresolution[1697:10514] starting screenresolution argv=screenresolution get 15:37:52 INFO - 2016-01-29 15:37:52.277 screenresolution[1697:10514] Display 0: 1600x1200x32@60 15:37:52 INFO - 2016-01-29 15:37:52.283 screenresolution[1698:10517] starting screenresolution argv=screenresolution list 15:37:52 INFO - Available Modes on Display 0 15:37:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:37:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:37:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:37:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:37:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:37:52 INFO - Intel Iris: 15:37:52 INFO - Chipset Model: Intel Iris 15:37:52 INFO - Type: GPU 15:37:52 INFO - Bus: Built-In 15:37:52 INFO - VRAM (Dynamic, Max): 1536 MB 15:37:52 INFO - Vendor: Intel (0x8086) 15:37:52 INFO - Device ID: 0x0a2e 15:37:52 INFO - Revision ID: 0x0009 15:37:52 INFO - Displays: 15:37:52 INFO - Display: 15:37:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:37:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:37:52 INFO - Display Serial Number: 1600x1200 60 15:37:52 INFO - Main Display: Yes 15:37:52 INFO - Mirror: Off 15:37:52 INFO - Online: Yes 15:37:52 INFO - Rotation: Supported 15:37:52 INFO - Return code: 0 15:37:52 INFO - Running post-action listener: _resource_record_post_action 15:37:52 INFO - Running post-run listener: _resource_record_post_run 15:37:53 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 33811968; Write bytes: 707430400; Read time: 354; Write time: 2342 15:37:53 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404230656; Write bytes: 405706752; Read time: 30651; Write time: 696 15:37:53 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32030208; Write bytes: 300433408; Read time: 336; Write time: 1643 15:37:53 INFO - Running post-run listener: _upload_blobber_files 15:37:53 INFO - Blob upload gear active. 15:37:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:37:53 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 15:37:53 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'] 15:37:53 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 15:37:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:37:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:37:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:37:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:55 INFO - (blobuploader) - INFO - Done attempting. 15:37:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:37:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:37:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:37:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:37:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:37:56 INFO - (blobuploader) - INFO - Done attempting. 15:37:56 INFO - (blobuploader) - INFO - Iteration through files over. 15:37:56 INFO - Return code: 0 15:37:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:37:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:37:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0054114a7ba5ad59b05becc681421f852f081116191d47c4feb769c6150abd87c9daa7941354f09320112dadc3163500cdb4bd9ca63b5e57b037d9722725cd3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a93f8dbf43403d45d0d98880554c4e1b0df0e5e52ddfb1ba694c79e16629bc7a57695c3343527830eae2d2420814fafd287dd05b7ce4d732ddd136b9e6f790"} 15:37:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:37:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:37:56 INFO - Contents: 15:37:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0054114a7ba5ad59b05becc681421f852f081116191d47c4feb769c6150abd87c9daa7941354f09320112dadc3163500cdb4bd9ca63b5e57b037d9722725cd3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a93f8dbf43403d45d0d98880554c4e1b0df0e5e52ddfb1ba694c79e16629bc7a57695c3343527830eae2d2420814fafd287dd05b7ce4d732ddd136b9e6f790"} 15:37:56 INFO - Running post-run listener: copy_logs_to_upload_dir 15:37:56 INFO - Copying logs to upload dir... 15:37:56 INFO - mkdir: /builds/slave/test/build/upload/logs 15:37:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.241517 ========= master_lag: 2.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-29 15:37:58.628882) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 15:37:58.632256) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0054114a7ba5ad59b05becc681421f852f081116191d47c4feb769c6150abd87c9daa7941354f09320112dadc3163500cdb4bd9ca63b5e57b037d9722725cd3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a93f8dbf43403d45d0d98880554c4e1b0df0e5e52ddfb1ba694c79e16629bc7a57695c3343527830eae2d2420814fafd287dd05b7ce4d732ddd136b9e6f790"} build_url:https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/NgzXiDwxTjemNu37Hm1zbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0054114a7ba5ad59b05becc681421f852f081116191d47c4feb769c6150abd87c9daa7941354f09320112dadc3163500cdb4bd9ca63b5e57b037d9722725cd3f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9a93f8dbf43403d45d0d98880554c4e1b0df0e5e52ddfb1ba694c79e16629bc7a57695c3343527830eae2d2420814fafd287dd05b7ce4d732ddd136b9e6f790"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 15:37:58.671244) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:37:58.671607) ========= 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.bmStMmMYXy/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.jwrKhUg0FM/Listeners TMPDIR=/var/folders/8l/2lld364j46g___08n54mb94h00000w/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.005304 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 15:37:58.720927) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 15:37:58.721259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 15:37:58.721680) ========= ========= Total master_lag: 2.65 =========